NormalizerFormatterTest.php 15 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362363364365366367368369370371372373374375376377378379380381382383384385386387388389390391392393394395396397398399400401402403404405406407408409410411412413414415416417418419420421422423424425426427428429430431432433434435436437438439440441442443444445446447448449450451452453454455456457458459460461462463464465466467468469
  1. <?php
  2. /*
  3. * This file is part of the Monolog package.
  4. *
  5. * (c) Jordi Boggiano <j.boggiano@seld.be>
  6. *
  7. * For the full copyright and license information, please view the LICENSE
  8. * file that was distributed with this source code.
  9. */
  10. namespace Monolog\Formatter;
  11. /**
  12. * @covers Monolog\Formatter\NormalizerFormatter
  13. */
  14. class NormalizerFormatterTest extends \PHPUnit_Framework_TestCase
  15. {
  16. public function tearDown()
  17. {
  18. \PHPUnit_Framework_Error_Warning::$enabled = true;
  19. return parent::tearDown();
  20. }
  21. public function testFormat()
  22. {
  23. $formatter = new NormalizerFormatter('Y-m-d');
  24. $formatted = $formatter->format(array(
  25. 'level_name' => 'ERROR',
  26. 'channel' => 'meh',
  27. 'message' => 'foo',
  28. 'datetime' => new \DateTime,
  29. 'extra' => array('foo' => new TestFooNorm, 'bar' => new TestBarNorm, 'baz' => array(), 'res' => fopen('php://memory', 'rb')),
  30. 'context' => array(
  31. 'foo' => 'bar',
  32. 'baz' => 'qux',
  33. 'inf' => INF,
  34. '-inf' => -INF,
  35. 'nan' => acos(4),
  36. ),
  37. ));
  38. $this->assertEquals(array(
  39. 'level_name' => 'ERROR',
  40. 'channel' => 'meh',
  41. 'message' => 'foo',
  42. 'datetime' => date('Y-m-d'),
  43. 'extra' => array(
  44. 'foo' => '[object] (Monolog\\Formatter\\TestFooNorm: {"foo":"foo"})',
  45. 'bar' => '[object] (Monolog\\Formatter\\TestBarNorm: bar)',
  46. 'baz' => array(),
  47. 'res' => '[resource] (stream)',
  48. ),
  49. 'context' => array(
  50. 'foo' => 'bar',
  51. 'baz' => 'qux',
  52. 'inf' => 'INF',
  53. '-inf' => '-INF',
  54. 'nan' => 'NaN',
  55. ),
  56. ), $formatted);
  57. }
  58. public function testFormatExceptions()
  59. {
  60. $formatter = new NormalizerFormatter('Y-m-d');
  61. $e = new \LogicException('bar');
  62. $e2 = new \RuntimeException('foo', 0, $e);
  63. $formatted = $formatter->format(array(
  64. 'exception' => $e2,
  65. ));
  66. $this->assertGreaterThan(5, count($formatted['exception']['trace']));
  67. $this->assertTrue(isset($formatted['exception']['previous']));
  68. unset($formatted['exception']['trace'], $formatted['exception']['previous']);
  69. $this->assertEquals(array(
  70. 'exception' => array(
  71. 'class' => get_class($e2),
  72. 'message' => $e2->getMessage(),
  73. 'code' => $e2->getCode(),
  74. 'file' => $e2->getFile().':'.$e2->getLine(),
  75. ),
  76. ), $formatted);
  77. }
  78. public function testFormatSoapFaultException()
  79. {
  80. if (!class_exists('SoapFault')) {
  81. $this->markTestSkipped('Requires the soap extension');
  82. }
  83. $formatter = new NormalizerFormatter('Y-m-d');
  84. $e = new \SoapFault('foo', 'bar', 'hello', 'world');
  85. $formatted = $formatter->format(array(
  86. 'exception' => $e,
  87. ));
  88. unset($formatted['exception']['trace']);
  89. $this->assertEquals(array(
  90. 'exception' => array(
  91. 'class' => 'SoapFault',
  92. 'message' => 'bar',
  93. 'code' => 0,
  94. 'file' => $e->getFile().':'.$e->getLine(),
  95. 'faultcode' => 'foo',
  96. 'faultactor' => 'hello',
  97. 'detail' => 'world',
  98. ),
  99. ), $formatted);
  100. }
  101. public function testFormatToStringExceptionHandle()
  102. {
  103. $formatter = new NormalizerFormatter('Y-m-d');
  104. $this->setExpectedException('RuntimeException', 'Could not convert to string');
  105. $formatter->format(array(
  106. 'myObject' => new TestToStringError(),
  107. ));
  108. }
  109. public function testBatchFormat()
  110. {
  111. $formatter = new NormalizerFormatter('Y-m-d');
  112. $formatted = $formatter->formatBatch(array(
  113. array(
  114. 'level_name' => 'CRITICAL',
  115. 'channel' => 'test',
  116. 'message' => 'bar',
  117. 'context' => array(),
  118. 'datetime' => new \DateTime,
  119. 'extra' => array(),
  120. ),
  121. array(
  122. 'level_name' => 'WARNING',
  123. 'channel' => 'log',
  124. 'message' => 'foo',
  125. 'context' => array(),
  126. 'datetime' => new \DateTime,
  127. 'extra' => array(),
  128. ),
  129. ));
  130. $this->assertEquals(array(
  131. array(
  132. 'level_name' => 'CRITICAL',
  133. 'channel' => 'test',
  134. 'message' => 'bar',
  135. 'context' => array(),
  136. 'datetime' => date('Y-m-d'),
  137. 'extra' => array(),
  138. ),
  139. array(
  140. 'level_name' => 'WARNING',
  141. 'channel' => 'log',
  142. 'message' => 'foo',
  143. 'context' => array(),
  144. 'datetime' => date('Y-m-d'),
  145. 'extra' => array(),
  146. ),
  147. ), $formatted);
  148. }
  149. /**
  150. * Test issue #137
  151. */
  152. public function testIgnoresRecursiveObjectReferences()
  153. {
  154. // set up the recursion
  155. $foo = new \stdClass();
  156. $bar = new \stdClass();
  157. $foo->bar = $bar;
  158. $bar->foo = $foo;
  159. // set an error handler to assert that the error is not raised anymore
  160. $that = $this;
  161. set_error_handler(function ($level, $message, $file, $line, $context) use ($that) {
  162. if (error_reporting() & $level) {
  163. restore_error_handler();
  164. $that->fail("$message should not be raised");
  165. }
  166. });
  167. $formatter = new NormalizerFormatter();
  168. $reflMethod = new \ReflectionMethod($formatter, 'toJson');
  169. $reflMethod->setAccessible(true);
  170. $res = $reflMethod->invoke($formatter, array($foo, $bar), true);
  171. restore_error_handler();
  172. $this->assertEquals(@json_encode(array($foo, $bar)), $res);
  173. }
  174. public function testCanNormalizeReferences()
  175. {
  176. $formatter = new NormalizerFormatter();
  177. $x = array('foo' => 'bar');
  178. $y = array('x' => &$x);
  179. $x['y'] = &$y;
  180. $formatter->format($y);
  181. }
  182. public function testIgnoresInvalidTypes()
  183. {
  184. // set up the recursion
  185. $resource = fopen(__FILE__, 'r');
  186. // set an error handler to assert that the error is not raised anymore
  187. $that = $this;
  188. set_error_handler(function ($level, $message, $file, $line, $context) use ($that) {
  189. if (error_reporting() & $level) {
  190. restore_error_handler();
  191. $that->fail("$message should not be raised");
  192. }
  193. });
  194. $formatter = new NormalizerFormatter();
  195. $reflMethod = new \ReflectionMethod($formatter, 'toJson');
  196. $reflMethod->setAccessible(true);
  197. $res = $reflMethod->invoke($formatter, array($resource), true);
  198. restore_error_handler();
  199. $this->assertEquals(@json_encode(array($resource)), $res);
  200. }
  201. public function testNormalizeHandleLargeArraysWithExactly1000Items()
  202. {
  203. $formatter = new NormalizerFormatter();
  204. $largeArray = range(1, 1000);
  205. $res = $formatter->format(array(
  206. 'level_name' => 'CRITICAL',
  207. 'channel' => 'test',
  208. 'message' => 'bar',
  209. 'context' => array($largeArray),
  210. 'datetime' => new \DateTime,
  211. 'extra' => array(),
  212. ));
  213. $this->assertCount(1000, $res['context'][0]);
  214. $this->assertArrayNotHasKey('...', $res['context'][0]);
  215. }
  216. public function testNormalizeHandleLargeArrays()
  217. {
  218. $formatter = new NormalizerFormatter();
  219. $largeArray = range(1, 2000);
  220. $res = $formatter->format(array(
  221. 'level_name' => 'CRITICAL',
  222. 'channel' => 'test',
  223. 'message' => 'bar',
  224. 'context' => array($largeArray),
  225. 'datetime' => new \DateTime,
  226. 'extra' => array(),
  227. ));
  228. $this->assertCount(1001, $res['context'][0]);
  229. $this->assertEquals('Over 1000 items (2000 total), aborting normalization', $res['context'][0]['...']);
  230. }
  231. /**
  232. * @expectedException RuntimeException
  233. */
  234. public function testThrowsOnInvalidEncoding()
  235. {
  236. if (version_compare(PHP_VERSION, '5.5.0', '<')) {
  237. // Ignore the warning that will be emitted by PHP <5.5.0
  238. \PHPUnit_Framework_Error_Warning::$enabled = false;
  239. }
  240. $formatter = new NormalizerFormatter();
  241. $reflMethod = new \ReflectionMethod($formatter, 'toJson');
  242. $reflMethod->setAccessible(true);
  243. // send an invalid unicode sequence as a object that can't be cleaned
  244. $record = new \stdClass;
  245. $record->message = "\xB1\x31";
  246. $res = $reflMethod->invoke($formatter, $record);
  247. if (PHP_VERSION_ID < 50500 && $res === '{"message":null}') {
  248. throw new \RuntimeException('PHP 5.3/5.4 throw a warning and null the value instead of returning false entirely');
  249. }
  250. }
  251. public function testConvertsInvalidEncodingAsLatin9()
  252. {
  253. if (version_compare(PHP_VERSION, '5.5.0', '<')) {
  254. // Ignore the warning that will be emitted by PHP <5.5.0
  255. \PHPUnit_Framework_Error_Warning::$enabled = false;
  256. }
  257. $formatter = new NormalizerFormatter();
  258. $reflMethod = new \ReflectionMethod($formatter, 'toJson');
  259. $reflMethod->setAccessible(true);
  260. $res = $reflMethod->invoke($formatter, array('message' => "\xA4\xA6\xA8\xB4\xB8\xBC\xBD\xBE"));
  261. if (version_compare(PHP_VERSION, '5.5.0', '>=')) {
  262. $this->assertSame('{"message":"€ŠšŽžŒœŸ"}', $res);
  263. } else {
  264. // PHP <5.5 does not return false for an element encoding failure,
  265. // instead it emits a warning (possibly) and nulls the value.
  266. $this->assertSame('{"message":null}', $res);
  267. }
  268. }
  269. /**
  270. * @param mixed $in Input
  271. * @param mixed $expect Expected output
  272. * @covers Monolog\Formatter\NormalizerFormatter::detectAndCleanUtf8
  273. * @dataProvider providesDetectAndCleanUtf8
  274. */
  275. public function testDetectAndCleanUtf8($in, $expect)
  276. {
  277. $formatter = new NormalizerFormatter();
  278. $formatter->detectAndCleanUtf8($in);
  279. $this->assertSame($expect, $in);
  280. }
  281. public function providesDetectAndCleanUtf8()
  282. {
  283. $obj = new \stdClass;
  284. return array(
  285. 'null' => array(null, null),
  286. 'int' => array(123, 123),
  287. 'float' => array(123.45, 123.45),
  288. 'bool false' => array(false, false),
  289. 'bool true' => array(true, true),
  290. 'ascii string' => array('abcdef', 'abcdef'),
  291. 'latin9 string' => array("\xB1\x31\xA4\xA6\xA8\xB4\xB8\xBC\xBD\xBE\xFF", '±1€ŠšŽžŒœŸÿ'),
  292. 'unicode string' => array('¤¦¨´¸¼½¾€ŠšŽžŒœŸ', '¤¦¨´¸¼½¾€ŠšŽžŒœŸ'),
  293. 'empty array' => array(array(), array()),
  294. 'array' => array(array('abcdef'), array('abcdef')),
  295. 'object' => array($obj, $obj),
  296. );
  297. }
  298. /**
  299. * @param int $code
  300. * @param string $msg
  301. * @dataProvider providesHandleJsonErrorFailure
  302. */
  303. public function testHandleJsonErrorFailure($code, $msg)
  304. {
  305. $formatter = new NormalizerFormatter();
  306. $reflMethod = new \ReflectionMethod($formatter, 'handleJsonError');
  307. $reflMethod->setAccessible(true);
  308. $this->setExpectedException('RuntimeException', $msg);
  309. $reflMethod->invoke($formatter, $code, 'faked');
  310. }
  311. public function providesHandleJsonErrorFailure()
  312. {
  313. return array(
  314. 'depth' => array(JSON_ERROR_DEPTH, 'Maximum stack depth exceeded'),
  315. 'state' => array(JSON_ERROR_STATE_MISMATCH, 'Underflow or the modes mismatch'),
  316. 'ctrl' => array(JSON_ERROR_CTRL_CHAR, 'Unexpected control character found'),
  317. 'default' => array(-1, 'Unknown error'),
  318. );
  319. }
  320. public function testExceptionTraceWithArgs()
  321. {
  322. if (defined('HHVM_VERSION')) {
  323. $this->markTestSkipped('Not supported in HHVM since it detects errors differently');
  324. }
  325. // This happens i.e. in React promises or Guzzle streams where stream wrappers are registered
  326. // and no file or line are included in the trace because it's treated as internal function
  327. set_error_handler(function ($errno, $errstr, $errfile, $errline) {
  328. throw new \ErrorException($errstr, 0, $errno, $errfile, $errline);
  329. });
  330. try {
  331. // This will contain $resource and $wrappedResource as arguments in the trace item
  332. $resource = fopen('php://memory', 'rw+');
  333. fwrite($resource, 'test_resource');
  334. $wrappedResource = new TestFooNorm;
  335. $wrappedResource->foo = $resource;
  336. // Just do something stupid with a resource/wrapped resource as argument
  337. array_keys($wrappedResource);
  338. } catch (\Exception $e) {
  339. restore_error_handler();
  340. }
  341. $formatter = new NormalizerFormatter();
  342. $record = array('context' => array('exception' => $e));
  343. $result = $formatter->format($record);
  344. $this->assertSame(
  345. __FILE__.':'.(__LINE__-10),
  346. $result['context']['exception']['trace'][0]
  347. );
  348. }
  349. public function testExceptionTraceDoesNotLeakCallUserFuncArgs()
  350. {
  351. try {
  352. $arg = new TestInfoLeak;
  353. call_user_func(array($this, 'throwHelper'), $arg, $dt = new \DateTime());
  354. } catch (\Exception $e) {
  355. }
  356. $formatter = new NormalizerFormatter();
  357. $record = array('context' => array('exception' => $e));
  358. $result = $formatter->format($record);
  359. $this->assertSame(
  360. __FILE__ .':'.(__LINE__-9),
  361. $result['context']['exception']['trace'][0]
  362. );
  363. }
  364. private function throwHelper($arg)
  365. {
  366. throw new \RuntimeException('Thrown');
  367. }
  368. }
  369. class TestFooNorm
  370. {
  371. public $foo = 'foo';
  372. }
  373. class TestBarNorm
  374. {
  375. public function __toString()
  376. {
  377. return 'bar';
  378. }
  379. }
  380. class TestStreamFoo
  381. {
  382. public $foo;
  383. public $resource;
  384. public function __construct($resource)
  385. {
  386. $this->resource = $resource;
  387. $this->foo = 'BAR';
  388. }
  389. public function __toString()
  390. {
  391. fseek($this->resource, 0);
  392. return $this->foo . ' - ' . (string) stream_get_contents($this->resource);
  393. }
  394. }
  395. class TestToStringError
  396. {
  397. public function __toString()
  398. {
  399. throw new \RuntimeException('Could not convert to string');
  400. }
  401. }
  402. class TestInfoLeak
  403. {
  404. public function __toString()
  405. {
  406. return 'Sensitive information';
  407. }
  408. }