Closed Bug 1598825 Opened 6 years ago Closed 6 years ago

Intermittent Tier 2 Windows netwerk/test/unit/test_trr.js | xpcshell return code: 0 | test_dnsSuffix - [test_dnsSuffix : 131] "2018::2018" == "127.0.0.1"

Tracking

()

Status:

RESOLVED DUPLICATE of bug 1597137

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, Whiteboard: [necko-triaged])

Treeherder Bug Filer

Reporter

Description

•

6 years ago

treeherder

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=277763803&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/SurI03xJQ22m275lfgLxEw/runs/0/artifacts/public/logs/live_backing.log

task 2019-11-23T01:00:21.072Z] 01:00:21 [task 2019-11-23T01:00:30.645Z] 01:00:30 [task 2019-11-23T01:00:30.667Z] 01:00:30 [task 2019-11-23T01:00:30.686Z] 01:00:30 [task 2019-11-23T01:00:40.368Z] 01:00:40 [task 2019-11-23T01:00:40.368Z] 01:00:40 [task 2019-11-23T01:00:40.369Z] 01:00:40 [task 2019-11-23T01:00:40.369Z] 01:00:40 [task 2019-11-23T01:00:40.370Z] 01:00:40 [task 2019-11-23T01:00:40.370Z] 01:00:40 [task 2019-11-23T01:00:40.370Z] 01:00:40 [task 2019-11-23T01:00:40.370Z] 01:00:40 [task 2019-11-23T01:00:40.370Z] 01:00:40 [task 2019-11-23T01:00:40.370Z] 01:00:40 [task 2019-11-23T01:00:40.371Z] 01:00:40 [task 2019-11-23T01:00:40.371Z] 01:00:40 [task 2019-11-23T01:00:40.371Z] 01:00:40 [task 2019-11-23T01:00:40.372Z] 01:00:40 [task 2019-11-23T01:00:40.372Z] 01:00:40 [task 2019-11-23T01:00:40.372Z] 01:00:40 [task 2019-11-23T01:00:40.373Z] 01:00:40 [task 2019-11-23T01:00:40.373Z] 01:00:40 [task 2019-11-23T01:00:40.374Z] 01:00:40 [task 2019-11-23T01:00:40.374Z] 01:00:40 [task 2019-11-23T01:00:40.374Z] 01:00:40 [task 2019-11-23T01:00:40.375Z] 01:00:40 [task 2019-11-23T01:00:40.375Z] 01:00:40 [task 2019-11-23T01:00:40.375Z] 01:00:40 [task 2019-11-23T01:00:40.376Z] 01:00:40 [task 2019-11-23T01:00:40.376Z] 01:00:40 [task 2019-11-23T01:00:40.376Z] 01:00:40 [task 2019-11-23T01:00:40.377Z] 01:00:40 [task 2019-11-23T01:00:40.377Z] 01:00:40 [task 2019-11-23T01:00:40.378Z] 01:00:40 [task 2019-11-23T01:00:40.378Z] 01:00:40 [task 2019-11-23T01:00:40.378Z] 01:00:40 [task 2019-11-23T01:00:40.379Z] 01:00:40 [task 2019-11-23T01:00:40.379Z] 01:00:40 [task 2019-11-23T01:00:40.379Z] 01:00:40 [task 2019-11-23T01:00:40.380Z] 01:00:40 [task 2019-11-23T01:00:40.380Z] 01:00:40 [task 2019-11-23T01:00:40.380Z] 01:00:40 [task 2019-11-23T01:00:40.381Z] 01:00:40 [task 2019-11-23T01:00:40.381Z] 01:00:40 [task 2019-11-23T01:00:40.381Z] 01:00:40 [task 2019-11-23T01:00:40.381Z] 01:00:40 [task 2019-11-23T01:00:40.382Z] 01:00:40 ...
...
[task 2019-11-23T01:00:40.474Z] 01:00:40 [task 2019-11-23T01:00:40.474Z] 01:00:40 [task 2019-11-23T01:00:40.474Z] 01:00:40 [task 2019-11-23T01:00:40.474Z] 01:00:40 [task 2019-11-23T01:00:40.474Z] 01:00:40 [task 2019-11-23T01:00:40.474Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.475Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.476Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.477Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.478Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.479Z] 01:00:40 [task 2019-11-23T01:00:40.528Z] 01:00:40 [task 2019-11-23T01:00:40.528Z] 01:00:40 INFO - TEST-START | netwerk/test/unit/test_captive_portal_service.js
INFO - TEST-PASS | netwerk/test/unit/test_captive_portal_service.js | took 9574ms
INFO - Retrying tests that failed when run in parallel.
INFO - TEST-START | netwerk/test/unit/test_trr.js
WARNING - TEST-UNEXPECTED-FAIL | netwerk/test/unit/test_trr.js | xpcshell return code: 0
INFO - TEST-INFO took 9682ms
INFO - >>>>>>>
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2632
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - PID 9160 | [9160, Main Thread] WARNING: 'result.isErr()', file z:/build/build/src/startupcache/StartupCache.cpp, line 173
INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
INFO - running event loop
INFO - PID 9160 | [9160, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file z:/build/build/src/dom/media/CubebUtils.cpp, line 381
INFO - netwerk/test/unit/test_trr.js | Starting setup
INFO - (xpcshell/head.js) | test setup pending (2)
INFO - PID 9160 | start!
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | setup - [setup : 35] "50033" != null
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | setup - [setup : 36] "50033" != ""
INFO - PID 9160 | [9160, Main Thread] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3212
INFO - PID 9160 | [9160, Main Thread] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3212
INFO - PID 9160 | [9160, Main Thread] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3212
INFO - (xpcshell/head.js) | test run_next_test 0 finished (2)
INFO - (xpcshell/head.js) | test run_next_test 1 pending (2)
INFO - (xpcshell/head.js) | test setup finished (2)
INFO - netwerk/test/unit/test_trr.js | Starting test0_nodeExecute
INFO - (xpcshell/head.js) | test test0_nodeExecute pending (2)
INFO - PID 9160 | [9160, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80004002: file z:/build/build/src/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 661
INFO - (xpcshell/head.js) | test run_next_test 1 finished (2)
INFO - PID 9160 | [9160, Main Thread] WARNING: 'NS_FAILED(rr->RetargetDeliveryTo(sts))', file z:/build/build/src/dom/fetch/FetchDriver.cpp, line 1078
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test0_nodeExecute - [test0_nodeExecute : 161] NodeServer is working - true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_connection_closed_trr_first - [test_connection_closed_trr_first : 131] "9.9.9.9" == "9.9.9.9"
INFO - (xpcshell/head.js) | test run_next_test 54 pending (2)
INFO - (xpcshell/head.js) | test test_connection_closed_trr_first finished (2)
INFO - netwerk/test/unit/test_trr.js | Starting test_clearCacheOnURIChange
INFO - (xpcshell/head.js) | test test_clearCacheOnURIChange pending (2)
INFO - (xpcshell/head.js) | test run_next_test 54 finished (2)
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_clearCacheOnURIChange - [test_clearCacheOnURIChange : 120] true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_clearCacheOnURIChange - [test_clearCacheOnURIChange : 129] 0 == 0
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_clearCacheOnURIChange - [test_clearCacheOnURIChange : 131] "7.7.7.7" == "7.7.7.7"
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_clearCacheOnURIChange - [test_clearCacheOnURIChange : 120] true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_clearCacheOnURIChange - [test_clearCacheOnURIChange : 129] 0 == 0
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_clearCacheOnURIChange - [test_clearCacheOnURIChange : 131] "8.8.8.8" == "8.8.8.8"
INFO - (xpcshell/head.js) | test run_next_test 55 pending (2)
INFO - (xpcshell/head.js) | test test_clearCacheOnURIChange finished (2)
INFO - netwerk/test/unit/test_trr.js | Starting test_dnsSuffix
INFO - (xpcshell/head.js) | test test_dnsSuffix pending (2)
INFO - (xpcshell/head.js) | test run_next_test 55 finished (2)
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 120] true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 129] 0 == 0
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 131] "1.2.3.4" == "1.2.3.4"
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 120] true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 129] 0 == 0
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 131] "2018::2018" == "2018::2018"
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 120] true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 129] 0 == 0
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 131] "127.0.0.1" == "127.0.0.1"
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 120] true == true
INFO - TEST-PASS | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 129] 0 == 0
WARNING - TEST-UNEXPECTED-FAIL | netwerk/test/unit/test_trr.js | test_dnsSuffix - [test_dnsSuffix : 131] "2018::2018" == "127.0.0.1"
INFO - Z:/task_1574467320/build/tests/xpcshell/tests/netwerk/test/unit/test_trr.js:onLookupComplete:131
INFO - Z:\task_1574467320\build\tests\xpcshell\head.js:_do_main:246
INFO - Z:\task_1574467320\build\tests\xpcshell\head.js:_execute_test:573
INFO - -e:null:1
INFO - exiting test
INFO - PID 9160 | JavaScript error: Z:\task_1574467320\build\tests\xpcshell\head.js, line 791: NS_ERROR_ABORT:
INFO - "CONSOLE_MESSAGE: (error) [JavaScript Error: "NS_ERROR_ABORT: " {file: "Z:\task_1574467320\build\tests\xpcshell\head.js" line: 791}]"
INFO - PID 9160 | [9160, Socket Thread] WARNING: cannot post event if not initialized: file z:/build/build/src/netwerk/protocol/http/nsHttpConnectionMgr.cpp, line 279
INFO - PID 9160 | [9160, Socket Thread] WARNING: cannot post event if not initialized: file z:/build/build/src/netwerk/protocol/http/nsHttpConnectionMgr.cpp, line 279
INFO - PID 9160 | [9160, Socket Thread] WARNING: cannot post event if not initialized: file z:/build/build/src/netwerk/protocol/http/nsHttpConnectionMgr.cpp, line 279
INFO - PID 9160 | [9160, Main Thread] WARNING: '!mIOThread', file z:/build/build/src/xpcom/io/nsSegmentedBuffer.cpp, line 165
INFO - PID 9160 | [9160, Main Thread] WARNING: '!mIOThread', file z:/build/build/src/xpcom/io/nsSegmentedBuffer.cpp, line 165
INFO - PID 9160 | [9160, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 3114
INFO - PID 9160 | [9160, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file z:/build/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
INFO - PID 9160 | [9160, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file z:/build/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
INFO - PID 9160 | nsStringStats
INFO - PID 9160 | => mAllocCount: 24763
INFO - PID 9160 | => mReallocCount: 0
INFO - PID 9160 | => mFreeCount: 24763
INFO - PID 9160 | => mShareCount: 16694
INFO - PID 9160 | => mAdoptCount: 235
INFO - PID 9160 | => mAdoptFreeCount: 235
INFO - PID 9160 | => Process ID: 9160, Thread ID: 5168
INFO - <<<<<<<
INFO - INFO | Result summary:
INFO - INFO | Passed: 580
WARNING - INFO | Failed: 1
WARNING - One or more unittests failed.
INFO - INFO | Todo: 0
INFO - INFO | Retried: 1
INFO - SUITE-END | took 746s
INFO - Node moz-http2 server shutting down ...
INFO - Process stderr
INFO - (node:4832) ExperimentalWarning: The http2 module is an experimental API.
INFO - (node:4832) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
INFO - (node:4832) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
INFO - (node:4832) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
INFO - (node:4832) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 window_update listeners added. Use emitter.setMaxListeners() to increase limit
ERROR - Return code: 1
INFO - TinderboxPrint: xpcshell-xpcshell<br/>580/<em class="testfail">1</em>/0

Comment hidden (Intermittent Failures Robot)

Honza Bambas (:mayhemer)

Comment 2

•

6 years ago

Valentin, AFAIK you have hands in TRR, right? Do you think this is a serious issue?

Flags: needinfo?(valentin.gosu)

Priority: P5 → P2

Whiteboard: [necko-triaged]

Valentin Gosu [:valentin]

Comment 3

•

6 years ago

The push with this test failure:
https://hg.mozilla.org/integration/autoland/file/cbe5a080a2ada0308ff3a8eae088ddd44b79af6d/netwerk/dns/nsHostResolver.cpp#l868
The patch I landed shortly after
https://searchfox.org/mozilla-central/rev/4df8821c1b824db5f40f381f48432f219d99ae36/netwerk/dns/nsHostResolver.cpp#869

It hasn't happened since I landed bug 1597137, so I think it's safe to dupe it.

Status: NEW → RESOLVED

Closed: 6 years ago

Flags: needinfo?(valentin.gosu)

Resolution: --- → DUPLICATE

Comment hidden (Intermittent Failures Robot)

You need to log in before you can comment on or make changes to this bug.

Bugzilla

Intermittent Tier 2 Windows netwerk/test/unit/test_trr.js | xpcshell return code: 0 | test_dnsSuffix - [test_dnsSuffix : 131] "2018::2018" == "127.0.0.1"

Categories

(Core :: Networking, defect, P2)

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, Whiteboard: [necko-triaged])

Crash Data

Security

(public)

User Story

Description

Comment 1

Comment 2

Comment 3

Comment 4