1870210 - Perma linux64-snap-amd64-nightly [tier 2] subprocess.CalledProcessError: Command '['/builds/worker/firefox-snap/parts/firefox/build/.mozbuild/srcdirs/build-0996710f2f4f/_virtualenvs/build/bin/python', /profileserver.py']' returned non-zero exit status 11.

Status: RESOLVED DUPLICATE of bug 1869010

(Firefox Build System :: Third Party Packaging, defect)

Description

[Iulian Moraru]

The failure summary is empty in treeherder.

• Push with first occurrence
• Parsed failure log
• Raw failure log

[task 2023-12-15T02:42:10.640Z] :: console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 406))
[task 2023-12-15T02:42:10.640Z] :: JavaScript error: resource://gre/modules/XULStore.sys.mjs, line 60: Error: Can't find profile directory.
[task 2023-12-15T02:42:10.640Z] :: console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.sys.mjs", 324))
[task 2023-12-15T02:42:10.640Z] :: JavaScript error: resource://gre/modules/XULStore.sys.mjs, line 60: Error: Can't find profile directory.
[task 2023-12-15T02:42:10.640Z] :: ExceptionHandler::GenerateDump cloned child 5166
[task 2023-12-15T02:42:10.640Z] :: ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2023-12-15T02:42:10.640Z] :: ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: Exiting due to channel error.
[task 2023-12-15T02:42:10.640Z] :: started SP3 server on port 8000
[task 2023-12-15T02:42:10.640Z] :: jarlog: /builds/worker/firefox-snap/parts/firefox/build/obj-x86_64-pc-linux-gnu/jarlog/en-US.log
[task 2023-12-15T02:42:10.640Z] :: Firefox exited with code 11 during profiling
[task 2023-12-15T02:42:10.640Z] ::  Config object not found by mach.
[task 2023-12-15T02:42:10.640Z] :: Configure complete!
[task 2023-12-15T02:42:10.640Z] :: Be sure to run |mach build| to pick up any changes
[task 2023-12-15T02:42:10.640Z] :: To view a profile of the build, run |mach resource-usage|.
[task 2023-12-15T02:42:10.640Z] :: To take your build for a test drive, run: |mach run|
[task 2023-12-15T02:42:10.640Z] :: For more information on what to do now, see https://firefox-source-docs.mozilla.org/setup/contributing_code.html
[task 2023-12-15T02:42:10.640Z] ::   Parallelism determined by memory: using 16 jobs for 16 cores based on 62.6 GiB RAM and estimated job size of 1.0 GiB
[task 2023-12-15T02:42:10.640Z] :: Error running mach:
[task 2023-12-15T02:42:10.640Z] ::
[task 2023-12-15T02:42:10.640Z] ::     mach build --verbose -j16
[task 2023-12-15T02:42:10.640Z] ::
[task 2023-12-15T02:42:10.640Z] :: The error occurred in code that was called by the mach command. This is either
[task 2023-12-15T02:42:10.640Z] :: a bug in the called code itself or in the way that mach is calling it.
[task 2023-12-15T02:42:10.640Z] :: You can invoke ``./mach busted`` to check if this issue is already on file. If it
[task 2023-12-15T02:42:10.640Z] :: isn't, please use ``./mach busted file build`` to report it. If ``./mach busted`` is
[task 2023-12-15T02:42:10.640Z] :: misbehaving, you can also inspect the dependencies of bug 1543241.
[task 2023-12-15T02:42:10.640Z] ::
[task 2023-12-15T02:42:10.640Z] :: If filing a bug, please include the full output of mach, including this error
[task 2023-12-15T02:42:10.640Z] :: message.
[task 2023-12-15T02:42:10.640Z] ::
[task 2023-12-15T02:42:10.640Z] :: The details of the failure are as follows:
[task 2023-12-15T02:42:10.640Z] ::
[task 2023-12-15T02:42:10.640Z] :: subprocess.CalledProcessError: Command '['/builds/worker/firefox-snap/parts/firefox/build/.mozbuild/srcdirs/build-0996710f2f4f/_virtualenvs/build/bin/python', '/builds/worker/firefox-snap/parts/firefox/build/build/pgo/profileserver.py']' returned non-zero exit status 11.
[task 2023-12-15T02:42:10.640Z] ::
[task 2023-12-15T02:42:10.640Z] ::   File "/builds/worker/firefox-snap/parts/firefox/build/python/mozbuild/mozbuild/build_commands.py", line 215, in build
[task 2023-12-15T02:42:10.640Z] ::     subprocess.check_call(pgo_cmd, cwd=instr.topobjdir, env=pgo_env)
[task 2023-12-15T02:42:10.640Z] ::   File "/usr/lib/python3.10/subprocess.py", line 369, in check_call
[task 2023-12-15T02:42:10.640Z] ::     raise CalledProcessError(retcode, cmd)
[task 2023-12-15T02:42:10.640Z] 'override-build' in part 'firefox' failed with code 1.
[task 2023-12-15T02:42:10.640Z] Review the scriptlet and make sure it's correct.
[task 2023-12-15T02:42:10.640Z] Full execution log: '/builds/worker/.local/state/snapcraft/log/snapcraft-20231215-013202.271498.log'
[taskcluster 2023-12-15 02:42:12.614Z] === Task Finished ===
[taskcluster 2023-12-15 02:42:13.135Z] Unsuccessful task run with exit code: 1 completed in 4405.694 seconds

Comment 1

[Iulian Moraru]

Hi Sylvestre! Can you please take a look at this? Could this be something caused by the recent changes from Bug 1840493?
Thank you!

Comment 2

[Mike Hommey [:glandium]]

Looks like upstream reactivated PGO, so effectively, this is the same as bug 1869010.