Closed Bug 1487935 Opened 7 years ago Closed 6 years ago

Intermittent toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | Uncaught exception - Simplified document title should be updated with recovery title. - timed out after 50 tries.

Categories

(Toolkit :: Printing, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: toros [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=196972365&repo=autoland https://queue.taskcluster.net/v1/task/SSXLieLJR6uXfS0RqEpyZQ/runs/0/artifacts/public/logs/live_backing.log [task 2018-08-31T23:05:13.279Z] 23:05:13 INFO - TEST-START | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js [task 2018-08-31T23:05:13.286Z] 23:05:13 INFO - GECKO(4114) | Chrome file doesn't exist: /builds/worker/workspace/build/tests/mochitest/browser/toolkit/components/printing/tests/head.js [task 2018-08-31T23:05:13.336Z] 23:05:13 INFO - GECKO(4114) | ++DOCSHELL 0x7fb5f286e000 == 2 [pid = 4246] [id = {6feaeddc-5983-40ca-baeb-6b1fbb85e7f2}] [task 2018-08-31T23:05:13.336Z] 23:05:13 INFO - GECKO(4114) | ++DOMWINDOW == 3 (0x7fb5f30fec00) [pid = 4246] [serial = 3] [outer = (nil)] [task 2018-08-31T23:05:13.356Z] 23:05:13 INFO - GECKO(4114) | ++DOMWINDOW == 2 (0x7f883d841800) [pid = 4304] [serial = 2] [outer = 0x7f8853a57a00] [task 2018-08-31T23:05:13.419Z] 23:05:13 INFO - GECKO(4114) | ++DOMWINDOW == 4 (0x7fb5f28a6400) [pid = 4246] [serial = 4] [outer = 0x7fb5f30fec00] [task 2018-08-31T23:05:13.496Z] 23:05:13 INFO - GECKO(4114) | [Child 4246, Main Thread] WARNING: site security information will not be persisted: file /builds/worker/workspace/build/src/security/manager/ssl/nsSiteSecurityService.cpp, line 553 [task 2018-08-31T23:05:13.516Z] 23:05:13 INFO - GECKO(4114) | Waiting for browser load [task 2018-08-31T23:05:13.619Z] 23:05:13 INFO - GECKO(4114) | Saw state f0001 and status 0 [task 2018-08-31T23:05:13.778Z] 23:05:13 INFO - GECKO(4114) | ++DOMWINDOW == 5 (0x7fb5f28a9800) [pid = 4246] [serial = 5] [outer = 0x7fb5f30fec00] [task 2018-08-31T23:05:14.004Z] 23:05:14 INFO - GECKO(4114) | Saw state c0010 and status 0 [task 2018-08-31T23:05:14.004Z] 23:05:14 INFO - GECKO(4114) | Browser loaded http://example.com/browser/toolkit/components/printing/tests/simplifyNonArticleSample.html [task 2018-08-31T23:05:14.025Z] 23:05:14 INFO - GECKO(4114) | ++DOCSHELL 0x7fb5f3167000 == 3 [pid = 4246] [id = {f5fd799c-9be7-427b-b0a4-ce68f1098b69}] [task 2018-08-31T23:05:14.026Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 6 (0x7fb5f30fee00) [pid = 4246] [serial = 6] [outer = (nil)] [task 2018-08-31T23:05:14.076Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 7 (0x7fb5f2c18c00) [pid = 4246] [serial = 7] [outer = 0x7fb5f30fee00] [task 2018-08-31T23:05:14.119Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 8 (0x7fb5f2c19800) [pid = 4246] [serial = 8] [outer = 0x7fb5f30fee00] [task 2018-08-31T23:05:14.155Z] 23:05:14 INFO - GECKO(4114) | ++DOCSHELL 0x7f977d04d800 == 10 [pid = 4114] [id = {7fd90e39-50c6-439d-a6f9-db42abff5eb4}] [task 2018-08-31T23:05:14.156Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 23 (0x7f97827fc800) [pid = 4114] [serial = 23] [outer = (nil)] [task 2018-08-31T23:05:14.158Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 24 (0x7f9784910c00) [pid = 4114] [serial = 24] [outer = 0x7f97827fc800] [task 2018-08-31T23:05:14.354Z] 23:05:14 INFO - GECKO(4114) | [Parent 4114, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x805D0021: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 1125 [task 2018-08-31T23:05:14.435Z] 23:05:14 INFO - GECKO(4114) | [Parent 4114, Main Thread] WARNING: NS_ENSURE_TRUE(root) failed: file /builds/worker/workspace/build/src/layout/base/nsDocumentViewer.cpp, line 3544 [task 2018-08-31T23:05:14.593Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 9 (0x7fb5f28ac800) [pid = 4246] [serial = 9] [outer = 0x7fb5f30fee00] [task 2018-08-31T23:05:14.609Z] 23:05:14 INFO - GECKO(4114) | ++DOMWINDOW == 10 (0x7fb5f2c1a000) [pid = 4246] [serial = 10] [outer = 0x7fb5f30fee00] [task 2018-08-31T23:05:15.052Z] 23:05:15 INFO - GECKO(4114) | ++DOCSHELL 0x7fb5f0d72000 == 4 [pid = 4246] [id = {8fa0569b-87c0-4112-a8af-ce7adad58b94}] [task 2018-08-31T23:05:15.053Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 11 (0x7fb5f28f6e00) [pid = 4246] [serial = 11] [outer = (nil)] [task 2018-08-31T23:05:15.090Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 12 (0x7fb5f0d3d400) [pid = 4246] [serial = 12] [outer = 0x7fb5f28f6e00] [task 2018-08-31T23:05:15.127Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 13 (0x7fb5f0d3e800) [pid = 4246] [serial = 13] [outer = 0x7fb5f28f6e00] [task 2018-08-31T23:05:15.386Z] 23:05:15 INFO - GECKO(4114) | ++DOCSHELL 0x7f977cfc6800 == 11 [pid = 4114] [id = {24c63999-4391-42cf-b9bf-a658966f441c}] [task 2018-08-31T23:05:15.388Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 25 (0x7f97827fd000) [pid = 4114] [serial = 25] [outer = (nil)] [task 2018-08-31T23:05:15.389Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 26 (0x7f9782e39800) [pid = 4114] [serial = 26] [outer = 0x7f97827fd000] [task 2018-08-31T23:05:15.492Z] 23:05:15 INFO - GECKO(4114) | [Parent 4114, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x805D0021: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 1125 [task 2018-08-31T23:05:15.509Z] 23:05:15 INFO - GECKO(4114) | [Parent 4114, Main Thread] WARNING: NS_ENSURE_TRUE(root) failed: file /builds/worker/workspace/build/src/layout/base/nsDocumentViewer.cpp, line 3544 [task 2018-08-31T23:05:15.649Z] 23:05:15 INFO - GECKO(4114) | ++DOCSHELL 0x7fb5f0d77800 == 5 [pid = 4246] [id = {334ad8e1-6d56-4051-8898-f9bc5726afb0}] [task 2018-08-31T23:05:15.651Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 14 (0x7fb5f28fba00) [pid = 4246] [serial = 14] [outer = (nil)] [task 2018-08-31T23:05:15.713Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 15 (0x7fb5f0d46800) [pid = 4246] [serial = 15] [outer = 0x7fb5f28fba00] [task 2018-08-31T23:05:15.790Z] 23:05:15 INFO - GECKO(4114) | [Child 4246, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1550 [task 2018-08-31T23:05:15.811Z] 23:05:15 INFO - GECKO(4114) | ++DOMWINDOW == 16 (0x7fb5f0d47c00) [pid = 4246] [serial = 16] [outer = 0x7fb5f28fba00] [task 2018-08-31T23:05:15.908Z] 23:05:15 INFO - GECKO(4114) | --DOMWINDOW == 6 (0x7fb353d7c000) [pid = 4204] [serial = 2] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:15.910Z] 23:05:15 INFO - GECKO(4114) | --DOMWINDOW == 5 (0x7fb353d83c00) [pid = 4204] [serial = 6] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:16.274Z] 23:05:16 INFO - GECKO(4114) | ++DOMWINDOW == 17 (0x7fb5f0d48800) [pid = 4246] [serial = 17] [outer = 0x7fb5f28f6e00] [task 2018-08-31T23:05:16.296Z] 23:05:16 INFO - GECKO(4114) | ++DOMWINDOW == 18 (0x7fb5f28acc00) [pid = 4246] [serial = 18] [outer = 0x7fb5f28f6e00] [task 2018-08-31T23:05:18.274Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f2d993b4000 == 1 [pid = 4274] [id = {dbc1d948-17cd-4dea-ab22-0ab09304b0b3}] [task 2018-08-31T23:05:18.275Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f2d98f6d000 == 0 [pid = 4274] [id = {136fa096-ca23-4711-8c2b-b89472aa36aa}] [task 2018-08-31T23:05:18.553Z] 23:05:18 INFO - GECKO(4114) | --DOMWINDOW == 4 (0x7fb36ae55200) [pid = 4204] [serial = 1] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:18.650Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7fb5f2cb4800 == 4 [pid = 4246] [id = {60cbc38e-6eb5-439e-b3c7-2669dad4a084}] [task 2018-08-31T23:05:18.690Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f977d04d800 == 10 [pid = 4114] [id = {7fd90e39-50c6-439d-a6f9-db42abff5eb4}] [task 2018-08-31T23:05:18.707Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f977cfd1000 == 9 [pid = 4114] [id = {2aa80641-c488-4aa2-8352-7073957e0812}] [task 2018-08-31T23:05:18.709Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f9784c04000 == 8 [pid = 4114] [id = {0f709a6d-8675-4c10-a228-c1c1ad7193ec}] [task 2018-08-31T23:05:18.715Z] 23:05:18 INFO - GECKO(4114) | --DOMWINDOW == 25 (0x7f9784e75400) [pid = 4114] [serial = 10] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:18.718Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f9782931000 == 7 [pid = 4114] [id = {bab003d7-7eb7-401e-9f05-3a3e90b24242}] [task 2018-08-31T23:05:18.719Z] 23:05:18 INFO - GECKO(4114) | --DOCSHELL 0x7f977cfc6800 == 6 [pid = 4114] [id = {24c63999-4391-42cf-b9bf-a658966f441c}] [task 2018-08-31T23:05:18.721Z] 23:05:18 INFO - GECKO(4114) | --DOMWINDOW == 24 (0x7f97827fc800) [pid = 4114] [serial = 23] [outer = (nil)] [url = chrome://global/content/printPreviewProgress.xul] [task 2018-08-31T23:05:18.723Z] 23:05:18 INFO - GECKO(4114) | --DOMWINDOW == 23 (0x7f9782941a00) [pid = 4114] [serial = 19] [outer = (nil)] [url = chrome://global/content/printPreviewProgress.xul] [task 2018-08-31T23:05:18.724Z] 23:05:18 INFO - GECKO(4114) | --DOMWINDOW == 22 (0x7f97827fd000) [pid = 4114] [serial = 25] [outer = (nil)] [url = chrome://global/content/printPreviewProgress.xul] [task 2018-08-31T23:05:18.725Z] 23:05:18 INFO - GECKO(4114) | --DOMWINDOW == 21 (0x7f97827fce00) [pid = 4114] [serial = 21] [outer = (nil)] [url = chrome://global/content/printPreviewProgress.xul] [task 2018-08-31T23:05:21.564Z] 23:05:21 INFO - TEST-INFO | started process screentopng [task 2018-08-31T23:05:22.024Z] 23:05:22 INFO - TEST-INFO | screentopng: exit 0 [task 2018-08-31T23:05:22.025Z] 23:05:22 INFO - Buffered messages logged at 23:05:13 [task 2018-08-31T23:05:22.026Z] 23:05:22 INFO - Entering test bound set_simplify_and_reader_pref [task 2018-08-31T23:05:22.027Z] 23:05:22 INFO - Leaving test bound set_simplify_and_reader_pref [task 2018-08-31T23:05:22.028Z] 23:05:22 INFO - Entering test bound switch_print_preview_browsers [task 2018-08-31T23:05:22.029Z] 23:05:22 INFO - Buffered messages logged at 23:05:14 [task 2018-08-31T23:05:22.029Z] 23:05:22 INFO - Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://example.com/browser/toolkit/components/printing/tests/simplifyNonArticleSample.html" line: 0}] [task 2018-08-31T23:05:22.030Z] 23:05:22 INFO - Buffered messages logged at 23:05:15 [task 2018-08-31T23:05:22.031Z] 23:05:22 INFO - TEST-PASS | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | Should have initial content. - "Non article title" == "Non article title" - [task 2018-08-31T23:05:22.032Z] 23:05:22 INFO - Buffered messages logged at 23:05:16 [task 2018-08-31T23:05:22.034Z] 23:05:22 INFO - TEST-PASS | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | Should have simplify page option checked - [task 2018-08-31T23:05:22.035Z] 23:05:22 INFO - Buffered messages finished [task 2018-08-31T23:05:22.036Z] 23:05:22 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | Uncaught exception - Simplified document title should be updated with recovery title. - timed out after 50 tries. [task 2018-08-31T23:05:22.037Z] 23:05:22 INFO - Leaving test bound switch_print_preview_browsers [task 2018-08-31T23:05:22.038Z] 23:05:22 INFO - GECKO(4114) | MEMORY STAT | vsize 1797MB | residentFast 286MB | heapAllocated 87MB [task 2018-08-31T23:05:22.039Z] 23:05:22 INFO - TEST-OK | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | took 8335ms [task 2018-08-31T23:05:22.040Z] 23:05:22 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-08-31T23:05:22.040Z] 23:05:22 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | Found an unexpected tab at the end of test run: about:printpreview - [task 2018-08-31T23:05:22.041Z] 23:05:22 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-08-31T23:05:22.042Z] 23:05:22 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_preview_print_simplify_non_article.js | Found an unexpected tab at the end of test run: about:printpreview - [task 2018-08-31T23:05:22.044Z] 23:05:22 INFO - GECKO(4114) | JavaScript error: chrome://browser/content/tabbrowser.xml, line 290: TypeError: this.selectedItem is null, can't access property "closing" of it [task 2018-08-31T23:05:22.044Z] 23:05:22 INFO - Console message: [JavaScript Error: "TypeError: this.selectedItem is null, can't access property "closing" of it" {file: "chrome://browser/content/tabbrowser.xml" line: 290}] [task 2018-08-31T23:05:22.045Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 5 (0x7f91c1d1f800) [pid = 4179] [serial = 5] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.046Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 4 (0x7f91c1d1a400) [pid = 4179] [serial = 2] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.234Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 9 (0x7f2d9a2af800) [pid = 4274] [serial = 7] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.235Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 8 (0x7f2d9a38b400) [pid = 4274] [serial = 8] [outer = (nil)] [url = http://example.com/browser/toolkit/components/printing/tests/file_page_change_print_original_1.html] [task 2018-08-31T23:05:22.236Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 7 (0x7f2d9a22c800) [pid = 4274] [serial = 2] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.238Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 6 (0x7f2d9a2b2c00) [pid = 4274] [serial = 5] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.239Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 5 (0x7f2d9a388c00) [pid = 4274] [serial = 6] [outer = (nil)] [url = about:printpreview] [task 2018-08-31T23:05:22.509Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 3 (0x7fb353d78c00) [pid = 4204] [serial = 3] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.510Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 2 (0x7fb353d83000) [pid = 4204] [serial = 4] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.672Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 17 (0x7fb5f28ac800) [pid = 4246] [serial = 9] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.673Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 16 (0x7fb5f28a6400) [pid = 4246] [serial = 4] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.674Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 15 (0x7fb5f0d3d400) [pid = 4246] [serial = 12] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.675Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 14 (0x7fb5f0d48800) [pid = 4246] [serial = 17] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.675Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 13 (0x7fb5f2c18c00) [pid = 4246] [serial = 7] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:22.676Z] 23:05:22 INFO - GECKO(4114) | --DOMWINDOW == 12 (0x7fb5f0d46800) [pid = 4246] [serial = 15] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:24.045Z] 23:05:24 INFO - GECKO(4114) | [Parent 4114, StreamTrans #29] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 417 [task 2018-08-31T23:05:24.045Z] 23:05:24 INFO - GECKO(4114) | [Parent 4114, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 1125 [task 2018-08-31T23:05:25.131Z] 23:05:25 INFO - GECKO(4114) | --DOMWINDOW == 11 (0x7fb609c56400) [pid = 4246] [serial = 1] [outer = (nil)] [url = about:blank] [task 2018-08-31T23:05:25.131Z] 23:05:25 INFO - GECKO(4114) | --DOCSHELL 0x7fb5f0d77800 == 3 [pid = 4246] [id = {334ad8e1-6d56-4051-8898-f9bc5726afb0}]
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.