Closed
Bug 1903660
Opened 1 year ago
Closed 1 year ago
Intermittent json.decoder.JSONDecodeError: Expecting ':' delimiter: line 1 column 92267844 (char 92267843)
Categories
(Testing :: General, defect, P5)
Testing
General
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=463200822&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/CVDCI33OS2CanEGDEVQo4w/runs/0/artifacts/public/logs/live_backing.log
[task 2024-06-19T21:44:20.913Z] 21:44:20 INFO - perftest-results-handler Info: Validating PERFHERDER_DATA against /opt/worker/tasks/task_171883026661659/mozharness/external_tools/performance-artifact-schema.json
[task 2024-06-19T21:44:20.916Z] 21:44:20 INFO - perftest-results-handler Info: Writing video jobs and application data {'jobs': [{'browsertime_json_path': 'browsertime-results/motionmark-animometer-ramp/browsertime.json', 'test_name': 'motionmark-animometer-ramp', 'tags': [], 'extra_options': ['fission', 'webrender'], 'accept_zero_vismet': False}], 'application': {'name': 'firefox', 'version': '129.0a1'}, 'extra_options': ['fission', 'webrender']} into /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/jobs.json
[task 2024-06-19T21:44:20.993Z] 21:44:20 INFO - raptor-profiling Info: Found 1 profiles: [{'path': '/opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/motionmark-animometer-ramp/profiling/pages/127_0_0_1/MotionMark/developer.html/query-99c328c5/data/geckoProfile-1.json.gz', 'type': 'benchmark'}]
[task 2024-06-19T21:44:20.995Z] 21:44:20 INFO - profiler Retrieving symbol zip from https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TVL2d12wQameYtlr914cfw/artifacts/public/build/target.crashreporter-symbols.zip...
[task 2024-06-19T21:44:41.058Z] 21:44:41 INFO - raptor-gecko-profile Info: Opening profile at /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/motionmark-animometer-ramp/profiling/pages/127_0_0_1/MotionMark/developer.html/query-99c328c5/data/geckoProfile-1.json.gz
[task 2024-06-19T21:44:45.781Z] 21:44:45 ERROR - Traceback (most recent call last):
[task 2024-06-19T21:44:45.782Z] 21:44:45 INFO - File "/opt/worker/tasks/task_171883026661659/build/tests/raptor/raptor/raptor.py", line 189, in <module>
[task 2024-06-19T21:44:45.782Z] 21:44:45 INFO - main()
[task 2024-06-19T21:44:45.782Z] 21:44:45 INFO - File "/opt/worker/tasks/task_171883026661659/build/tests/raptor/raptor/raptor.py", line 138, in main
[task 2024-06-19T21:44:45.782Z] 21:44:45 INFO - success = raptor.run_tests(raptor_test_list, raptor_test_names)
[task 2024-06-19T21:44:45.782Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.783Z] 21:44:45 INFO - File "/opt/worker/tasks/task_171883026661659/build/tests/raptor/raptor/perftest.py", line 510, in run_tests
[task 2024-06-19T21:44:45.783Z] 21:44:45 INFO - return self.process_results(tests, test_names)
[task 2024-06-19T21:44:45.783Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.783Z] 21:44:45 INFO - File "/opt/worker/tasks/task_171883026661659/build/tests/raptor/raptor/perftest.py", line 540, in process_results
[task 2024-06-19T21:44:45.783Z] 21:44:45 INFO - self.gecko_profiler.symbolicate()
[task 2024-06-19T21:44:45.783Z] 21:44:45 INFO - File "/opt/worker/tasks/task_171883026661659/build/tests/raptor/raptor/gecko_profile.py", line 171, in symbolicate
[task 2024-06-19T21:44:45.784Z] 21:44:45 INFO - profile = self._open_profile_file(profile_path)
[task 2024-06-19T21:44:45.784Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.784Z] 21:44:45 INFO - File "/opt/worker/tasks/task_171883026661659/build/tests/raptor/raptor/raptor_profiling.py", line 39, in _open_profile_file
[task 2024-06-19T21:44:45.784Z] 21:44:45 INFO - profile = json.load(profile_file)
[task 2024-06-19T21:44:45.784Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.785Z] 21:44:45 INFO - File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/json/__init__.py", line 293, in load
[task 2024-06-19T21:44:45.785Z] 21:44:45 INFO - return loads(fp.read(),
[task 2024-06-19T21:44:45.785Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.785Z] 21:44:45 INFO - File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/json/__init__.py", line 346, in loads
[task 2024-06-19T21:44:45.785Z] 21:44:45 INFO - return _default_decoder.decode(s)
[task 2024-06-19T21:44:45.785Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/json/decoder.py", line 337, in decode
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end())
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/json/decoder.py", line 353, in raw_decode
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - obj, end = self.scan_once(s, idx)
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - ^^^^^^^^^^^^^^^^^^^^^^
[task 2024-06-19T21:44:45.786Z] 21:44:45 INFO - json.decoder.JSONDecodeError: Expecting ':' delimiter: line 1 column 92267844 (char 92267843)
[task 2024-06-19T21:44:45.905Z] 21:44:45 INFO - Return code: 1
[task 2024-06-19T21:44:45.905Z] 21:44:45 WARNING - setting return code to 1
[task 2024-06-19T21:44:45.906Z] 21:44:45 INFO - Copying Raptor results to upload dir:
[task 2024-06-19T21:44:45.906Z] 21:44:45 INFO - /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/perfherder-data.json
[task 2024-06-19T21:44:45.906Z] 21:44:45 INFO - Copying raptor results from /opt/worker/tasks/task_171883026661659/build/raptor.json to /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/perfherder-data.json
[task 2024-06-19T21:44:45.907Z] 21:44:45 INFO - Running post-action listener: _package_coverage_data
[task 2024-06-19T21:44:45.907Z] 21:44:45 INFO - Running post-action listener: _resource_record_post_action
[task 2024-06-19T21:44:45.907Z] 21:44:45 INFO - Running post-action listener: process_java_coverage_data
[task 2024-06-19T21:44:45.907Z] 21:44:45 INFO - Running post-action listener: stop_device
[task 2024-06-19T21:44:45.907Z] 21:44:45 INFO - [mozharness: 2024-06-19 21:44:45.907392Z] Finished run-tests step (success)
[task 2024-06-19T21:44:45.907Z] 21:44:45 INFO - Running post-run listener: _resource_record_post_run
[task 2024-06-19T21:44:46.212Z] 21:44:46 INFO - Total resource usage - Wall time: 768s; CPU: 14%; Read bytes: 94863360; Write bytes: 5215535104; Read time: 1498; Write time: 8107
[task 2024-06-19T21:44:46.212Z] 21:44:46 INFO - TinderboxPrint: CPU usage<br/>13.6%
[task 2024-06-19T21:44:46.212Z] 21:44:46 INFO - TinderboxPrint: I/O read bytes / time<br/>94,863,360 / 1,498
[task 2024-06-19T21:44:46.212Z] 21:44:46 INFO - TinderboxPrint: I/O write bytes / time<br/>5,215,535,104 / 8,107
[task 2024-06-19T21:44:46.213Z] 21:44:46 INFO - TinderboxPrint: CPU idle<br/>7,976.4 (86.6%)
[task 2024-06-19T21:44:46.213Z] 21:44:46 INFO - TinderboxPrint: CPU system<br/>297.3 (3.2%)
[task 2024-06-19T21:44:46.213Z] 21:44:46 INFO - TinderboxPrint: CPU user<br/>933.3 (10.1%)
[task 2024-06-19T21:44:46.213Z] 21:44:46 INFO - TinderboxPrint: Swap in / out<br/>569,679,872 / 0
[task 2024-06-19T21:44:46.214Z] 21:44:46 INFO - install-chromium-distribution - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-06-19T21:44:46.216Z] 21:44:46 INFO - install - Wall time: 37s; CPU: 14%; Read bytes: 507205120; Write bytes: 502190080; Read time: 34674; Write time: 914
[task 2024-06-19T21:44:46.256Z] 21:44:46 INFO - run-tests - Wall time: 730s; CPU: 14%; Read bytes: 85643264; Write bytes: 4712624128; Read time: 1335; Write time: 7186
[task 2024-06-19T21:44:47.582Z] 21:44:47 WARNING - returning nonzero exit status 1
[taskcluster 2024-06-19T21:44:47.664Z] Exit Code: 1
[taskcluster 2024-06-19T21:44:47.664Z] User Time: 14m38.215662s
[taskcluster 2024-06-19T21:44:47.664Z] Kernel Time: 2m21.849695s
[taskcluster 2024-06-19T21:44:47.664Z] Wall Time: 15m14.057675s
[taskcluster 2024-06-19T21:44:47.664Z] Result: FAILED
[taskcluster 2024-06-19T21:44:47.665Z] === Task Finished ===
[taskcluster 2024-06-19T21:44:47.665Z] Task Duration: 15m14.061858s
[taskcluster 2024-06-19T21:44:47.973Z] Uploading artifact public/logs/localconfig.json from file /opt/worker/tasks/task_171883026661659/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:48.275Z] Uploading artifact public/test_info/browsertime-results/jobs.json from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/jobs.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:48.551Z] Uploading artifact public/test_info/browsertime-results/motionmark-animometer-ramp/browsertime.json from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/motionmark-animometer-ramp/browsertime.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:49.033Z] Uploading artifact public/test_info/browsertime-results/motionmark-animometer-ramp/profiling/browsertime.json from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/motionmark-animometer-ramp/profiling/browsertime.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:49.357Z] Uploading artifact public/test_info/browsertime-results/motionmark-animometer-ramp/profiling/pages/127_0_0_1/MotionMark/developer.html/query-99c328c5/data/geckoProfile-1.json.gz from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/browsertime-results/motionmark-animometer-ramp/profiling/pages/127_0_0_1/MotionMark/developer.html/query-99c328c5/data/geckoProfile-1.json.gz with content encoding "identity", mime type "application/octet-stream" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:50.302Z] Uploading artifact public/test_info/perfherder-data.json from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/perfherder-data.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:50.573Z] Uploading artifact public/test_info/profile_motionmark-animometer-ramp.zip from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/profile_motionmark-animometer-ramp.zip with content encoding "identity", mime type "application/zip" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:50.842Z] Uploading artifact public/test_info/profile_resource-usage.json from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:51.208Z] Uploading artifact public/test_info/resource-usage.json from file /opt/worker/tasks/task_171883026661659/build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2025-06-19T19:06:45.365Z
[taskcluster 2024-06-19T21:44:51.754Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2025-06-19T19:06:45.365Z
[taskcluster:error] exit status 1
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•