Closed Bug 1447947 Opened 8 years ago Closed 8 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | application timed out after 370 seconds with no output

Tracking

()

Status:

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Treeherder Bug Filer

Reporter

Description

•

8 years ago

treeherder

Filed by: apavel [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=169626393&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/Ln6NxVOQQhuXr30iwej4fw/runs/0/artifacts/public/logs/live_backing.log [task 2018-03-22T10:29:57.025Z] 10:29:57 INFO - TEST-PASS | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | ServiceWorker: true: no-cors Request fetch should result in opaque response [task 2018-03-22T10:29:57.026Z] 10:29:57 INFO - Buffered messages logged at 10:23:46 [task 2018-03-22T10:29:57.026Z] 10:29:57 INFO - TEST-PASS | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | ServiceWorker: true: Expected test failure for ({pass:0, method:"GET", noAllowPreflight:1, username:"user"}) [task 2018-03-22T10:29:57.027Z] 10:29:57 INFO - TEST-PASS | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | ServiceWorker: true: Exception should be TypeError for ({pass:0, method:"GET", noAllowPreflight:1, username:"user"}) [task 2018-03-22T10:29:57.028Z] 10:29:57 INFO - Buffered messages finished [task 2018-03-22T10:29:57.029Z] 10:29:57 ERROR - TEST-UNEXPECTED-TIMEOUT | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | application timed out after 370 seconds with no output [task 2018-03-22T10:29:57.030Z] 10:29:57 ERROR - Force-terminating active process(es). [task 2018-03-22T10:29:57.031Z] 10:29:57 INFO - Determining child pids from psutil... [task 2018-03-22T10:29:57.032Z] 10:29:57 INFO - [5179] [task 2018-03-22T10:29:57.033Z] 10:29:57 INFO - ==> process 5073 launched child process 5096 [task 2018-03-22T10:29:57.034Z] 10:29:57 INFO - ==> process 5073 launched child process 5124 [task 2018-03-22T10:29:57.035Z] 10:29:57 INFO - ==> process 5073 launched child process 5179 [task 2018-03-22T10:29:57.036Z] 10:29:57 INFO - ==> process 5073 launched child process 5291 [task 2018-03-22T10:29:57.037Z] 10:29:57 INFO - Found child pids: set([5096, 5179, 5124, 5291]) [task 2018-03-22T10:29:57.038Z] 10:29:57 INFO - Failed to get child procs [task 2018-03-22T10:29:57.039Z] 10:29:57 INFO - Killing process: 5096 [task 2018-03-22T10:29:57.040Z] 10:29:57 INFO - TEST-INFO | started process screentopng [task 2018-03-22T10:29:57.449Z] 10:29:57 INFO - TEST-INFO | screentopng: exit 0 [task 2018-03-22T10:29:57.454Z] 10:29:57 INFO - Can't trigger Breakpad, process no longer exists [task 2018-03-22T10:29:57.456Z] 10:29:57 INFO - Killing process: 5179 [task 2018-03-22T10:29:57.457Z] 10:29:57 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-03-22T10:29:57.457Z] 10:29:57 INFO - Killing process: 5124 [task 2018-03-22T10:29:57.458Z] 10:29:57 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-03-22T10:29:57.459Z] 10:29:57 INFO - Can't trigger Breakpad, process no longer exists [task 2018-03-22T10:29:57.459Z] 10:29:57 INFO - Killing process: 5291 [task 2018-03-22T10:29:57.460Z] 10:29:57 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-03-22T10:29:57.462Z] 10:29:57 INFO - Can't trigger Breakpad, process no longer exists [task 2018-03-22T10:29:57.463Z] 10:29:57 INFO - Killing process: 5073 [task 2018-03-22T10:29:57.465Z] 10:29:57 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-03-22T10:29:57.624Z] 10:29:57 INFO - psutil found pid 5073 dead [task 2018-03-22T10:29:57.661Z] 10:29:57 WARNING - runtests.py | Failed to get app exit code - running/crashed? [task 2018-03-22T10:29:57.662Z] 10:29:57 INFO - TEST-INFO | Main app process: exit 0 [task 2018-03-22T10:29:57.661Z] 10:29:57 WARNING - runtests.py | Failed to get app exit code - running/crashed? [task 2018-03-22T10:29:57.662Z] 10:29:57 INFO - TEST-INFO | Main app process: exit 0 [task 2018-03-22T10:29:57.663Z] 10:29:57 INFO - runtests.py | Application ran for: 0:06:30.913155 [task 2018-03-22T10:29:57.663Z] 10:29:57 INFO - zombiecheck | Reading PID log: /tmp/tmpBKsdHEpidlog [task 2018-03-22T10:29:57.664Z] 10:29:57 INFO - ==> process 5073 launched child process 5096 [task 2018-03-22T10:29:57.664Z] 10:29:57 INFO - ==> process 5073 launched child process 5124 [task 2018-03-22T10:29:57.665Z] 10:29:57 INFO - ==> process 5073 launched child process 5179 [task 2018-03-22T10:29:57.666Z] 10:29:57 INFO - ==> process 5073 launched child process 5291 [task 2018-03-22T10:29:57.667Z] 10:29:57 INFO - zombiecheck | Checking for orphan process with PID: 5096 [task 2018-03-22T10:29:57.667Z] 10:29:57 INFO - zombiecheck | Checking for orphan process with PID: 5179 [task 2018-03-22T10:29:57.668Z] 10:29:57 INFO - zombiecheck | Checking for orphan process with PID: 5124 [task 2018-03-22T10:29:57.668Z] 10:29:57 INFO - zombiecheck | Checking for orphan process with PID: 5291 [task 2018-03-22T10:29:57.668Z] 10:29:57 INFO - mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/O8kerSM0RtSBQXcxkf-njA/artifacts/public/build/target.crashreporter-symbols.zip [task 2018-03-22T10:30:03.644Z] 10:30:03 INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmpU9_YVl.mozrunner/minidumps/32c65ffd-95cd-ba11-1b83-277f7a680e77.dmp /tmp/tmpIZzvWs [task 2018-03-22T10:30:11.683Z] 10:30:11 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/32c65ffd-95cd-ba11-1b83-277f7a680e77.dmp [task 2018-03-22T10:30:11.684Z] 10:30:11 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/32c65ffd-95cd-ba11-1b83-277f7a680e77.extra [task 2018-03-22T10:30:11.813Z] 10:30:11 INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ libc-2.23.so + 0xfb74d] [task 2018-03-22T10:30:11.814Z] 10:30:11 INFO - Crash dump filename: /tmp/tmpU9_YVl.mozrunner/minidumps/32c65ffd-95cd-ba11-1b83-277f7a680e77.dmp [task 2018-03-22T10:30:11.815Z] 10:30:11 INFO - Operating system: Linux [task 2018-03-22T10:30:11.816Z] 10:30:11 INFO - 0.0.0 Linux 4.4.0-1014-aws #14taskcluster-Ubuntu SMP Mon Feb 19 11:31:26 UTC 2018 x86_64 [task 2018-03-22T10:30:11.816Z] 10:30:11 INFO - CPU: amd64 [task 2018-03-22T10:30:11.817Z] 10:30:11 INFO - family 6 model 62 stepping 4 [task 2018-03-22T10:30:11.818Z] 10:30:11 INFO - 2 CPUs [task 2018-03-22T10:30:11.819Z] 10:30:11 INFO - [task 2018-03-22T10:30:11.820Z] 10:30:11 INFO - GPU: UNKNOWN [task 2018-03-22T10:30:11.820Z] 10:30:11 INFO - [task 2018-03-22T10:30:11.821Z] 10:30:11 INFO - Crash reason: SIGABRT [task 2018-03-22T10:30:11.822Z] 10:30:11 INFO - Crash address: 0x3e8000003d9 [task 2018-03-22T10:30:11.823Z] 10:30:11 INFO - Process uptime: not available [task 2018-03-22T10:30:11.823Z] 10:30:11 INFO - [task 2018-03-22T10:30:11.824Z] 10:30:11 INFO - Thread 0 (crashed) [task 2018-03-22T10:30:11.825Z] 10:30:11 INFO - 0 libc-2.23.so + 0xfb74d [task 2018-03-22T10:30:11.826Z] 10:30:11 INFO - rax = 0xfffffffffffffffc rdx = 0x00000000ffffffff [task 2018-03-22T10:30:11.827Z] 10:30:11 INFO - rcx = 0x00007f341317974d rbx = 0x00007f33f51ff420 [task 2018-03-22T10:30:11.828Z] 10:30:11 INFO - rsi = 0x0000000000000003 rdi = 0x00007f33f51ff420 [task 2018-03-22T10:30:11.829Z] 10:30:11 INFO - rbp = 0x00007fffe064b560 rsp = 0x00007fffe064b530 [task 2018-03-22T10:30:11.829Z] 10:30:11 INFO - r8 = 0x0000000000000003 r9 = 0x0000000000000001 [task 2018-03-22T10:30:11.830Z] 10:30:11 INFO - r10 = 0x00007f33f9568360 r11 = 0x0000000000000293 [task 2018-03-22T10:30:11.831Z] 10:30:11 INFO - r12 = 0x0000000000000003 r13 = 0x00000000ffffffff [task 2018-03-22T10:30:11.832Z] 10:30:11 INFO - r14 = 0x00007f3403fd9df0 r15 = 0x0000000000000003 [task 2018-03-22T10:30:11.833Z] 10:30:11 INFO - rip = 0x00007f341317974d [task 2018-03-22T10:30:11.834Z] 10:30:11 INFO - Found by: given as instruction pointer in context [task 2018-03-22T10:30:11.835Z] 10:30:11 INFO - 1 libxul.so!PollWrapper [nsAppShell.cpp:9dd29f87106500717371eb180fff29bf1b9d5f2a : 53 + 0xf] [task 2018-03-22T10:30:11.836Z] 10:30:11 INFO - rbp = 0x00007fffe064b560 rsp = 0x00007fffe064b540 [task 2018-03-22T10:30:11.837Z] 10:30:11 INFO - rip = 0x00007f3403fd9e1f [task 2018-03-22T10:30:11.838Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.839Z] 10:30:11 INFO - 2 libglib-2.0.so.0.4800.2 + 0x4a38c [task 2018-03-22T10:30:11.839Z] 10:30:11 INFO - rbx = 0x00007f3412ec1df0 rbp = 0x0000000000000003 [task 2018-03-22T10:30:11.840Z] 10:30:11 INFO - rsp = 0x00007fffe064b570 r12 = 0x00007f33f51ff420 [task 2018-03-22T10:30:11.841Z] 10:30:11 INFO - r13 = 0x00000000ffffffff rip = 0x00007f340dfb938c [task 2018-03-22T10:30:11.842Z] 10:30:11 INFO - Found by: call frame info [task 2018-03-22T10:30:11.843Z] 10:30:11 INFO - 3 libglib-2.0.so.0.4800.2 + 0x4a49c [task 2018-03-22T10:30:11.844Z] 10:30:11 INFO - rsp = 0x00007fffe064b5d0 rip = 0x00007f340dfb949c [task 2018-03-22T10:30:11.845Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.846Z] 10:30:11 INFO - 4 libxul.so!nsAppShell::ProcessNextNativeEvent [nsAppShell.cpp:9dd29f87106500717371eb180fff29bf1b9d5f2a : 295 + 0x5] [task 2018-03-22T10:30:11.847Z] 10:30:11 INFO - rsp = 0x00007fffe064b5f0 rip = 0x00007f3403fd9e6f [task 2018-03-22T10:30:11.848Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.848Z] 10:30:11 INFO - 5 libxul.so!nsBaseAppShell::DoProcessNextNativeEvent [nsBaseAppShell.cpp:9dd29f87106500717371eb180fff29bf1b9d5f2a : 139 + 0x10] [task 2018-03-22T10:30:11.849Z] 10:30:11 INFO - rsp = 0x00007fffe064b600 rip = 0x00007f3403fa706c [task 2018-03-22T10:30:11.850Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.851Z] 10:30:11 INFO - 6 libxul.so!nsBaseAppShell::OnProcessNextEvent [nsBaseAppShell.cpp:9dd29f87106500717371eb180fff29bf1b9d5f2a : 290 + 0x8] [task 2018-03-22T10:30:11.852Z] 10:30:11 INFO - rsp = 0x00007fffe064b630 rip = 0x00007f3403fa7210 [task 2018-03-22T10:30:11.853Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.854Z] 10:30:11 INFO - 7 libxul.so!nsThread::ProcessNextEvent [nsThread.cpp:9dd29f87106500717371eb180fff29bf1b9d5f2a : 984 + 0xf] [task 2018-03-22T10:30:11.855Z] 10:30:11 INFO - rsp = 0x00007fffe064b680 rip = 0x00007f3401fd049d [task 2018-03-22T10:30:11.856Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.857Z] 10:30:11 INFO - 8 libxul.so!PrintfAppend<char>::append [nsTSubstring.h:9dd29f87106500717371eb180fff29bf1b9d5f2a : 399 + 0x8] [task 2018-03-22T10:30:11.858Z] 10:30:11 INFO - rsp = 0x00007fffe064b6e0 rip = 0x00007f3401f4ebc8 [task 2018-03-22T10:30:11.859Z] 10:30:11 INFO - Found by: stack scanning [task 2018-03-22T10:30:11.860Z] 10:30:11 INFO - 9 firefox!arena_t::SplitRun [mozjemalloc.cpp:9dd29f87106500717371eb180fff29bf1b9d5f2a : 2373 + 0x2] [task 2018-03-22T10:30:11.861Z] 10:30:11 INFO - rsp = 0x00007fffe064b710 rip = 0x000000000040da01 [task 2018-03-22T10:30:11.862Z] 10:30:11 INFO - Found by: stack scanning

Comment hidden (Intermittent Failures Robot)

Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)

Updated

•

8 years ago

Component: DOM → DOM: Service Workers

Comment hidden (Intermittent Failures Robot)

Firefox Bug Husbandry Bot

Comment 3

•

8 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: NEW → RESOLVED

Closed: 8 years ago

Resolution: --- → INCOMPLETE

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

Bugzilla

Intermittent TEST-UNEXPECTED-TIMEOUT | dom/tests/mochitest/fetch/test_fetch_cors_sw_empty_reroute.html | application timed out after 370 seconds with no output

Categories

(Core :: DOM: Service Workers, defect, P5)

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

Crash Data

Security

(public)

User Story

Description

Comment 1

Updated

Comment 2

Comment 3