Closed Bug 1719022 Opened 5 years ago Closed 5 years ago

Intermittent TVw1 ::: Test verification FAIL | TinderboxPrint: Per-test run of .../tests/encoding/encodeInto.any.js<br/>: FAILURE

Categories

(Core :: Internationalization, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=344261631&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YmZNiMt7TDyesxSDAFW0NA/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YmZNiMt7TDyesxSDAFW0NA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1


INFO - | `encodeInto() and a detached output buffer`                                                                     | PASS    |                                                                                                                       |
[task 2021-07-03T05:43:39.642Z] 05:43:39     INFO - 
[task 2021-07-03T05:43:39.643Z] 05:43:39     INFO - ## Slow tests ##
[task 2021-07-03T05:43:39.643Z] 05:43:39     INFO - 
[task 2021-07-03T05:43:39.643Z] 05:43:39     INFO - |                      Test                     | Result | Longest duration (ms) | Timeout (ms) |
[task 2021-07-03T05:43:39.643Z] 05:43:39     INFO - |-----------------------------------------------|--------|-----------------------|--------------|
[task 2021-07-03T05:43:39.643Z] 05:43:39     INFO - | `/encoding/encodeInto.any.serviceworker.html` | `OK`   | `12113`               | `10000`      |
[task 2021-07-03T05:43:39.644Z] 05:43:39     INFO - 
[task 2021-07-03T05:43:39.644Z] 05:43:39     INFO - ::: Running tests in a loop 10 times : PASS
[task 2021-07-03T05:43:39.644Z] 05:43:39     INFO - ::: Running tests in a loop with restarts 5 times : PASS
[task 2021-07-03T05:43:39.645Z] 05:43:39     INFO - ::: Running tests in a loop 10 times with flags chaos_mode_flags=0xfb : FAIL
[task 2021-07-03T05:43:39.645Z] 05:43:39     INFO - :::
[task 2021-07-03T05:43:39.645Z] 05:43:39    ERROR - ::: Test verification FAIL
[task 2021-07-03T05:43:39.645Z] 05:43:39     INFO - :::
[task 2021-07-03T05:43:39.898Z] 05:43:39    ERROR - Return code: 1
[task 2021-07-03T05:43:39.898Z] 05:43:39    ERROR - # TBPL FAILURE #
[task 2021-07-03T05:43:39.898Z] 05:43:39  WARNING - setting return code to 2
[task 2021-07-03T05:43:39.898Z] 05:43:39    ERROR - TinderboxPrint: Per-test run of .../tests/encoding/encodeInto.any.js<br/>: FAILURE
[task 2021-07-03T05:43:39.900Z] 05:43:39     INFO - Running command: ['/opt/worker/tasks/task_162527649240436/build/venv/bin/python', '-u', '/opt/worker/tasks/task_162527649240436/build/tests/web-platform/runtests.py', '--log-raw=-', '--log-raw=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt-test4_raw.log', '--log-wptreport=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wptreport.json', '--log-errorsummary=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt-test4_errorsummary.log', '--binary=/opt/worker/tasks/task_162527649240436/build/application/Firefox Nightly.app/Contents/MacOS/firefox', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/M0l0GrBiRBaRaJM-3K-hQA/artifacts/public/build/target.crashreporter-symbols.zip', '--stackwalk-binary=/opt/worker/tasks/task_162527649240436/fetches/minidump_stackwalk/minidump_stackwalk', '--stackfix-dir=/opt/worker/tasks/task_162527649240436/build/tests/bin', '--no-pause-after-test', '--instrument-to-file=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt_instruments.txt', '--specialpowers-path=/opt/worker/tasks/task_162527649240436/build/tests/extensions/specialpowers@mozilla.org.xpi', '--processes=2', '--install-fonts', '--test-type=testharness', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--enable-webrender', '--prefs-root=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/prefs', '--config=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/wptrunner.ini', '--ca-cert-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/cacert.pem', '--host-key-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/web-platform.test.key', '--host-cert-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/web-platform.test.pem', '--certutil-binary=/opt/worker/tasks/task_162527649240436/build/tests/bin/certutil', '--verify-log-full', '--verify', 'tests/web-platform/tests/fetch/api/response/response-clone.any.js'] in /opt/worker/tasks/task_162527649240436/build
[task 2021-07-03T05:43:39.901Z] 05:43:39     INFO - Copy/paste: /opt/worker/tasks/task_162527649240436/build/venv/bin/python -u /opt/worker/tasks/task_162527649240436/build/tests/web-platform/runtests.py --log-raw=- --log-raw=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt-test4_raw.log --log-wptreport=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wptreport.json --log-errorsummary=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt-test4_errorsummary.log "--binary=/opt/worker/tasks/task_162527649240436/build/application/Firefox Nightly.app/Contents/MacOS/firefox" --symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/M0l0GrBiRBaRaJM-3K-hQA/artifacts/public/build/target.crashreporter-symbols.zip --stackwalk-binary=/opt/worker/tasks/task_162527649240436/fetches/minidump_stackwalk/minidump_stackwalk --stackfix-dir=/opt/worker/tasks/task_162527649240436/build/tests/bin --no-pause-after-test --instrument-to-file=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt_instruments.txt --specialpowers-path=/opt/worker/tasks/task_162527649240436/build/tests/extensions/specialpowers@mozilla.org.xpi --processes=2 --install-fonts --test-type=testharness --setpref=media.peerconnection.mtransport_process=false --setpref=network.process.enabled=false --setpref=layers.d3d11.enable-blacklist=false --enable-webrender --prefs-root=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/prefs --config=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/wptrunner.ini --ca-cert-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/cacert.pem --host-key-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/web-platform.test.key --host-cert-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/web-platform.test.pem --certutil-binary=/opt/worker/tasks/task_162527649240436/build/tests/bin/certutil --verify-log-full --verify tests/web-platform/tests/fetch/api/response/response-clone.any.js
[task 2021-07-03T05:43:39.901Z] 05:43:39     INFO - Using env: (same as previous command)
[task 2021-07-03T05:43:39.901Z] 05:43:39     INFO - Calling ['/opt/worker/tasks/task_162527649240436/build/venv/bin/python', '-u', '/opt/worker/tasks/task_162527649240436/build/tests/web-platform/runtests.py', '--log-raw=-', '--log-raw=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt-test4_raw.log', '--log-wptreport=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wptreport.json', '--log-errorsummary=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt-test4_errorsummary.log', '--binary=/opt/worker/tasks/task_162527649240436/build/application/Firefox Nightly.app/Contents/MacOS/firefox', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/M0l0GrBiRBaRaJM-3K-hQA/artifacts/public/build/target.crashreporter-symbols.zip', '--stackwalk-binary=/opt/worker/tasks/task_162527649240436/fetches/minidump_stackwalk/minidump_stackwalk', '--stackfix-dir=/opt/worker/tasks/task_162527649240436/build/tests/bin', '--no-pause-after-test', '--instrument-to-file=/opt/worker/tasks/task_162527649240436/build/blobber_upload_dir/wpt_instruments.txt', '--specialpowers-path=/opt/worker/tasks/task_162527649240436/build/tests/extensions/specialpowers@mozilla.org.xpi', '--processes=2', '--install-fonts', '--test-type=testharness', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--enable-webrender', '--prefs-root=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/prefs', '--config=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/wptrunner.ini', '--ca-cert-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/cacert.pem', '--host-key-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/web-platform.test.key', '--host-cert-path=/opt/worker/tasks/task_162527649240436/build/tests/web-platform/tests/tools/certs/web-platform.test.pem', '--certutil-binary=/opt/worker/tasks/task_162527649240436/build/tests/bin/certutil', '--verify-log-full', '--verify', 'tests/web-platform/tests/fetch/api/response/response-clone.any.js'] with output_timeout 1000
[task 2021-07-03T05:43:40.152Z] 05:43:40     INFO - :::
[task 2021-07-03T05:43:40.153Z] 05:43:40     INFO - ::: Running test verification step "Running tests in a loop 10 times"...
[task 2021-07-03T05:43:40.153Z] 05:43:40     INFO - :::
[task 2021-07-03T05:43:40.332Z] 05:43:40     INFO - mozversion application_buildid: 20210703045804
[task 2021-07-03T05:43:40.333Z] 05:43:40     INFO - mozversion application_changeset: 42496ca2c712c0c68515d69b8e7b152a932e7985
[task 2021-07-03T05:43:40.333Z] 05:43:40     INFO - mozversion application_display_name: Firefox Nightly
[task 2021-07-03T05:43:40.333Z] 05:43:40     INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
[task 2021-07-03T05:43:40.333Z] 05:43:40     INFO - mozversion application_name: Firefox
[task 2021-07-03T05:43:40.334Z] 05:43:40     INFO - mozversion application_remotingname: firefox
[task 2021-07-03T05:43:40.334Z] 05:43:40     INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland
[task 2021-07-03T05:43:40.334Z] 05:43:40     INFO - mozversion application_vendor: Mozilla
[task 2021-07-03T05:43:40.334Z] 05:43:40     INFO - mozversion application_version: 91.0a1
INFO - mozversion platform_buildid: 20210703045804
[task 2021-07-03T05:43:40.335Z] 05:43:40     INFO - mozversion platform_changeset: 42496ca2c712c0c68515d69b8e7b152a932e7985
[task 2021-07-03T05:43:40.335Z] 05:43:40     INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland
[task 2021-07-03T05:43:40.335Z] 05:43:40     INFO - mozversion platform_version: 91.0a1
[task 2021-07-03T05:43:43.076Z] 05:43:43     INFO - Using 2 client processes
[task 2021-07-03T05:43:46.319Z] 05:43:46     INFO - Installed font: Ahem.ttf
[task 2021-07-03T05:43:46.712Z] 05:43:46     INFO - wptserve Starting http server on 127.0.0.1:8000
[task 2021-07-03T05:43:47.073Z] 05:43:47     INFO - wptserve Starting http server on 127.0.0.1:8001
[task 2021-07-03T05:43:47.437Z] 05:43:47     INFO - wptserve Starting http server on 127.0.0.1:8002
[task 2021-07-03T05:43:47.800Z] 05:43:47     INFO - wptserve Starting http server on 127.0.0.1:8003
[task 2021-07-03T05:43:48.162Z] 05:43:48     INFO - wptserve Starting https server on 127.0.0.1:8443
[task 2021-07-03T05:43:48.522Z] 05:43:48     INFO - wptserve Starting https server on 127.0.0.1:8444
[task 2021-07-03T05:43:48.884Z] 05:43:48     INFO - wptserve Starting https server on 127.0.0.1:8445
[task 2021-07-03T05:43:49.245Z] 05:43:49     INFO - wptserve Starting https server on 127.0.0.1:8446
[task 2021-07-03T05:43:49.606Z] 05:43:49     INFO - wptserve Create socket on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2021-07-03T05:43:49.606Z] 05:43:49     INFO - wptserve Bind on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2021-07-03T05:43:49.606Z] 05:43:49     INFO - wptserve Listen on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2021-07-03T05:43:49.967Z] 05:43:49     INFO - wptserve Create socket on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2021-07-03T05:43:49.968Z] 05:43:49     INFO - wptserve Bind on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2021-07-03T05:43:49.969Z] 05:43:49     INFO - wptserve Listen on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2021-07-03T05:43:50.323Z] 05:43:50     INFO - wptserve Starting http2 server on 127.0.0.1:9000
[task 2021-07-03T05:43:50.879Z] 05:43:50     INFO - SUITE-START | Running 4 tests
[task 2021-07-03T05:43:50.879Z] 05:43:50     INFO - Running testharness tests
[task 2021-07-03T05:43:50.918Z] 05:43:50     INFO - Setting up ssl
[task 2021-07-03T05:43:50.921Z] 05:43:50     INFO - Setting up ssl
[task 2021-07-03T05:43:50.949Z] 05:43:50     INFO - certutil | b''
[task 2021-07-03T05:43:50.951Z] 05:43:50     INFO - certutil | b''
[task 2021-07-03T05:43:50.981Z] 05:43:50     INFO - certutil | b''
[task 2021-07-03T05:43:50.983Z] 05:43:50     INFO - certutil | b''
[task 2021-07-03T05:43:51.007Z] 05:43:51     INFO - certutil | b'\nCertificate Nickname                                         Trust Attributes\n                                                             SSL,S/MIME,JAR/XPI\n\nweb-platform-tests                                           CT,, \n'
[task 2021-07-03T05:43:51.010Z] 05:43:51     INFO - certutil | b'\nCertificate Nickname                                         Trust Attributes\n                                                             SSL,S/MIME,JAR/XPI\n\nweb-platform-tests                                           CT,, \n'
[task 2021-07-03T05:43:51.018Z] 05:43:51     INFO - Application command: /opt/worker/tasks/task_162527649240436/build/application/Firefox Nightly.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/6_/2fr28cdd7y77jbw9wg779c0r000014/T/tmp2epyuf0u
[task 2021-07-03T05:43:51.023Z] 05:43:51     INFO - Application command: /opt/worker/tasks/task_162527649240436/build/application/Firefox Nightly.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/6_/2fr28cdd7y77jbw9wg779c0r000014/T/tmp1gi6hxbo
[task 2021-07-03T05:43:51.025Z] 05:43:51     INFO - Starting runner
[task 2021-07-03T05:43:51.031Z] 05:43:51     INFO - Starting runner
[task 2021-07-03T05:43:51.451Z] 05:43:51     INFO - PID 10254 | 1625291031450	Marionette	INFO	Marionette enabled
INFO - PID 10253 | 1625291031464	Marionette	INFO	Marionette enabled
[task 2021-07-03T05:43:51.556Z] 05:43:51     INFO - PID 10254 | 2021-07-03 05:43:51.554 firefox[10254:151107] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightly.savedState/window_1.data: No such file or directory (2)
[task 2021-07-03T05:43:52.311Z] 05:43:52     INFO - PID 10254 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /var/folders/6_/2fr28cdd7y77jbw9wg779c0r000014/T/tmp1gi6hxbo/search.json.mozlz4", (void 0)))
[task 2021-07-03T05:43:52.328Z] 05:43:52     INFO - PID 10253 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /var/folders/6_/2fr28cdd7y77jbw9wg779c0r000014/T/tmp2epyuf0u/search.json.mozlz4", (void 0)))
[task 2021-07-03T05:43:53.116Z] 05:43:53     INFO - PID 10254 | 1625291033115	Marionette	INFO	Listening on port 52438
[task 2021-07-03T05:43:53.135Z] 05:43:53     INFO - PID 10253 | 1625291033134	Marionette	INFO	Listening on port 52437
[task 2021-07-03T05:43:53.233Z] 05:43:53     INFO - TEST-START | /fetch/api/response/response-clone.any.sharedworker.html
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.