builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1455195742.88 results: success (0) buildid: 20160211023003 builduid: a33aefedd3df4cac875f4ba48a330e01 revision: ed1086f28ad16013658981a24fbd154913632710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.885090) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.885551) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.885854) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.909226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.909534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.922691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.923063) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.972354) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.972649) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.973052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:22.973326) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 05:02:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-02-11 05:02:23 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194201 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:23.180893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:23.181200) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019430 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:23.242733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:23.243076) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ed1086f28ad16013658981a24fbd154913632710 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ed1086f28ad16013658981a24fbd154913632710 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 05:02:23,689 truncating revision to first 12 chars 2016-02-11 05:02:23,689 Setting DEBUG logging. 2016-02-11 05:02:23,689 attempt 1/10 2016-02-11 05:02:23,689 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ed1086f28ad1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 05:02:24,298 unpacking tar archive at: fx-team-ed1086f28ad1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:24.162762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:24.163080) ========= echo ed1086f28ad16013658981a24fbd154913632710 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ed1086f28ad16013658981a24fbd154913632710'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ed1086f28ad16013658981a24fbd154913632710 program finished with exit code 0 elapsedTime=0.003950 script_repo_revision: 'ed1086f28ad16013658981a24fbd154913632710' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:24.215682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:24.216553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 05:02:24.227802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-11 05:02:24.228170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:02:24 INFO - MultiFileLogger online at 20160211 05:02:24 in /builds/slave/test-pgo 05:02:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:02:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:02:24 INFO - {'append_to_log': False, 05:02:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:02:24 INFO - 'blob_upload_branch': 'Fx-Team', 05:02:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:02:24 INFO - 'branch': 'Fx-Team', 05:02:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:24 INFO - 'config_files': ('talos/linux_config.py',), 05:02:24 INFO - 'default_actions': ('clobber', 05:02:24 INFO - 'read-buildbot-config', 05:02:24 INFO - 'download-and-extract', 05:02:24 INFO - 'populate-webroot', 05:02:24 INFO - 'create-virtualenv', 05:02:24 INFO - 'install', 05:02:24 INFO - 'run-tests'), 05:02:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:24 INFO - 'download_minidump_stackwalk': True, 05:02:24 INFO - 'download_symbols': 'ondemand', 05:02:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:24 INFO - 'installer_path': 'installer.exe', 05:02:24 INFO - 'log_level': 'info', 05:02:24 INFO - 'log_name': 'talos', 05:02:24 INFO - 'log_to_console': True, 05:02:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:02:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:02:24 INFO - 'opt_config_files': (), 05:02:24 INFO - 'pip_index': False, 05:02:24 INFO - 'sps_profile': False, 05:02:24 INFO - 'sps_profile_interval': 0, 05:02:24 INFO - 'suite': 'dromaeojs', 05:02:24 INFO - 'system_bits': '32', 05:02:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:24 INFO - 'title': 'talos-linux64-ix-031', 05:02:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:24 INFO - 'use_talos_json': True, 05:02:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:02:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:24 INFO - 'work_dir': 'build'} 05:02:24 INFO - ##### 05:02:24 INFO - ##### Running clobber step. 05:02:24 INFO - ##### 05:02:24 INFO - Running pre-action listener: _resource_record_pre_action 05:02:24 INFO - Running main action method: clobber 05:02:24 INFO - rmtree: /builds/slave/test-pgo/build 05:02:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - ##### 05:02:25 INFO - ##### Running read-buildbot-config step. 05:02:25 INFO - ##### 05:02:25 INFO - Running pre-action listener: _resource_record_pre_action 05:02:25 INFO - Running main action method: read_buildbot_config 05:02:25 INFO - Using buildbot properties: 05:02:25 INFO - { 05:02:25 INFO - "project": "", 05:02:25 INFO - "product": "firefox", 05:02:25 INFO - "script_repo_revision": "production", 05:02:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:02:25 INFO - "repository": "", 05:02:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:02:25 INFO - "buildid": "20160211023003", 05:02:25 INFO - "pgo_build": "True", 05:02:25 INFO - "basedir": "/builds/slave/test-pgo", 05:02:25 INFO - "buildnumber": 488, 05:02:25 INFO - "slavename": "talos-linux64-ix-031", 05:02:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:02:25 INFO - "platform": "ubuntu64_hw", 05:02:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:02:25 INFO - "branch": "fx-team", 05:02:25 INFO - "repo_path": "integration/fx-team", 05:02:25 INFO - "revision": "ed1086f28ad16013658981a24fbd154913632710", 05:02:25 INFO - "stage_platform": "linux64-pgo", 05:02:25 INFO - "builduid": "a33aefedd3df4cac875f4ba48a330e01", 05:02:25 INFO - "slavebuilddir": "test" 05:02:25 INFO - } 05:02:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - ##### 05:02:25 INFO - ##### Running download-and-extract step. 05:02:25 INFO - ##### 05:02:25 INFO - Running pre-action listener: _resource_record_pre_action 05:02:25 INFO - Running main action method: download_and_extract 05:02:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:25 INFO - https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:02:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/test_packages.json 05:02:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/test_packages.json 05:02:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:02:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:02:30 INFO - Downloaded 1448 bytes. 05:02:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:02:30 INFO - Using the following test package requirements: 05:02:30 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:30 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:30 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:02:30 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'jsshell-linux-x86_64.zip'], 05:02:30 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:30 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:30 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:02:30 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:02:30 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:30 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:30 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:30 INFO - https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:31 INFO - Downloaded 23293514 bytes. 05:02:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:02:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:02:33 INFO - Return code: 0 05:02:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:33 INFO - https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:02:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:02:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:34 INFO - Downloaded 23293514 bytes. 05:02:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:02:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:02:36 INFO - Return code: 0 05:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:36 INFO - https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:02:37 INFO - Downloaded 10706547 bytes. 05:02:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:02:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:02:37 INFO - Return code: 0 05:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:37 INFO - https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:02:38 INFO - Downloaded 56470696 bytes. 05:02:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:02:38 INFO - mkdir: /builds/slave/test-pgo/properties 05:02:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:02:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:02:38 INFO - Contents: 05:02:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:02:39 INFO - Running post-action listener: _resource_record_post_action 05:02:39 INFO - Running post-action listener: set_extra_try_arguments 05:02:39 INFO - ##### 05:02:39 INFO - ##### Running populate-webroot step. 05:02:39 INFO - ##### 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: populate_webroot 05:02:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:39 INFO - '--tppagecycles', 05:02:39 INFO - '7'], 05:02:39 INFO - 'tests': ['tsvgm']}}, 05:02:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:02:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:02:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'tests': ['damp', 'tps']}, 05:02:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['damp', 'tps']}, 05:02:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:02:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:39 INFO - 'other': {'tests': ['a11yr', 05:02:39 INFO - 'ts_paint', 05:02:39 INFO - 'tpaint', 05:02:39 INFO - 'sessionrestore', 05:02:39 INFO - 'sessionrestore_no_auto_restore']}, 05:02:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['a11yr', 05:02:39 INFO - 'ts_paint', 05:02:39 INFO - 'tpaint', 05:02:39 INFO - 'sessionrestore', 05:02:39 INFO - 'sessionrestore_no_auto_restore']}, 05:02:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['a11yr', 05:02:39 INFO - 'ts_paint', 05:02:39 INFO - 'tpaint', 05:02:39 INFO - 'sessionrestore', 05:02:39 INFO - 'sessionrestore_no_auto_restore']}, 05:02:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['a11yr', 05:02:39 INFO - 'ts_paint', 05:02:39 INFO - 'tpaint', 05:02:39 INFO - 'sessionrestore', 05:02:39 INFO - 'sessionrestore_no_auto_restore']}, 05:02:39 INFO - 'other_l64': {'tests': ['a11yr', 05:02:39 INFO - 'ts_paint', 05:02:39 INFO - 'tpaint', 05:02:39 INFO - 'sessionrestore', 05:02:39 INFO - 'sessionrestore_no_auto_restore']}, 05:02:39 INFO - 'other_nol64': {'tests': ['a11yr', 05:02:39 INFO - 'ts_paint', 05:02:39 INFO - 'tpaint', 05:02:39 INFO - 'sessionrestore', 05:02:39 INFO - 'sessionrestore_no_auto_restore']}, 05:02:39 INFO - 'svgr': {'tests': ['tsvgx', 05:02:39 INFO - 'tsvgr_opacity', 05:02:39 INFO - 'tart', 05:02:39 INFO - 'tscrollx', 05:02:39 INFO - 'cart']}, 05:02:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['tsvgx', 05:02:39 INFO - 'tsvgr_opacity', 05:02:39 INFO - 'tart', 05:02:39 INFO - 'tscrollx', 05:02:39 INFO - 'cart']}, 05:02:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'tests': ['tp5o']}, 05:02:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'talos_options': ['--e10s'], 05:02:39 INFO - 'tests': ['tp5o']}, 05:02:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'talos_options': ['--xperf_path', 05:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:39 INFO - 'tests': ['tp5n']}, 05:02:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:39 INFO - 'talos_options': ['--e10s', 05:02:39 INFO - '--xperf_path', 05:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:39 INFO - 'tests': ['tp5n']}}, 05:02:39 INFO - 'talos.zip': {'path': '', 05:02:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:39 INFO - Running post-action listener: _resource_record_post_action 05:02:39 INFO - ##### 05:02:39 INFO - ##### Running create-virtualenv step. 05:02:39 INFO - ##### 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: create_virtualenv 05:02:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:02:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:02:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:02:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:39 INFO - Using real prefix '/usr' 05:02:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:02:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:42 INFO - Installing pip.................done. 05:02:42 INFO - Return code: 0 05:02:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:02:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:02:42 INFO - Using env: {'DISPLAY': ':0', 05:02:42 INFO - 'HOME': '/home/cltbld', 05:02:42 INFO - 'LANG': 'en_US.UTF-8', 05:02:42 INFO - 'LANGUAGE': 'en_US:en', 05:02:42 INFO - 'LOGNAME': 'cltbld', 05:02:42 INFO - 'MAIL': '/var/mail/cltbld', 05:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:42 INFO - 'MOZ_NO_REMOTE': '1', 05:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:42 INFO - 'NO_EM_RESTART': '1', 05:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:42 INFO - 'SHELL': '/bin/bash', 05:02:42 INFO - 'SHLVL': '1', 05:02:42 INFO - 'TERM': 'linux', 05:02:42 INFO - 'TMOUT': '86400', 05:02:42 INFO - 'USER': 'cltbld', 05:02:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:42 INFO - '_': '/tools/buildbot/bin/python'} 05:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:02:42 INFO - Cleaning up... 05:02:42 INFO - Return code: 0 05:02:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:02:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:02:42 INFO - Using env: {'DISPLAY': ':0', 05:02:42 INFO - 'HOME': '/home/cltbld', 05:02:42 INFO - 'LANG': 'en_US.UTF-8', 05:02:42 INFO - 'LANGUAGE': 'en_US:en', 05:02:42 INFO - 'LOGNAME': 'cltbld', 05:02:42 INFO - 'MAIL': '/var/mail/cltbld', 05:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:42 INFO - 'MOZ_NO_REMOTE': '1', 05:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:42 INFO - 'NO_EM_RESTART': '1', 05:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:42 INFO - 'SHELL': '/bin/bash', 05:02:42 INFO - 'SHLVL': '1', 05:02:42 INFO - 'TERM': 'linux', 05:02:42 INFO - 'TMOUT': '86400', 05:02:42 INFO - 'USER': 'cltbld', 05:02:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:42 INFO - '_': '/tools/buildbot/bin/python'} 05:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:42 INFO - Downloading/unpacking psutil>=0.7.1 05:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:44 INFO - Installing collected packages: psutil 05:02:44 INFO - Running setup.py install for psutil 05:02:44 INFO - building 'psutil._psutil_linux' extension 05:02:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:02:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:02:44 INFO - building 'psutil._psutil_posix' extension 05:02:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:02:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:44 INFO - Successfully installed psutil 05:02:44 INFO - Cleaning up... 05:02:44 INFO - Return code: 0 05:02:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:02:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:02:44 INFO - Using env: {'DISPLAY': ':0', 05:02:44 INFO - 'HOME': '/home/cltbld', 05:02:44 INFO - 'LANG': 'en_US.UTF-8', 05:02:44 INFO - 'LANGUAGE': 'en_US:en', 05:02:44 INFO - 'LOGNAME': 'cltbld', 05:02:44 INFO - 'MAIL': '/var/mail/cltbld', 05:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:44 INFO - 'MOZ_NO_REMOTE': '1', 05:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:44 INFO - 'NO_EM_RESTART': '1', 05:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:44 INFO - 'SHELL': '/bin/bash', 05:02:44 INFO - 'SHLVL': '1', 05:02:44 INFO - 'TERM': 'linux', 05:02:44 INFO - 'TMOUT': '86400', 05:02:44 INFO - 'USER': 'cltbld', 05:02:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:44 INFO - '_': '/tools/buildbot/bin/python'} 05:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:02:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:02:47 INFO - Installing collected packages: mozsystemmonitor 05:02:47 INFO - Running setup.py install for mozsystemmonitor 05:02:47 INFO - Successfully installed mozsystemmonitor 05:02:47 INFO - Cleaning up... 05:02:47 INFO - Return code: 0 05:02:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:02:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:02:47 INFO - Using env: {'DISPLAY': ':0', 05:02:47 INFO - 'HOME': '/home/cltbld', 05:02:47 INFO - 'LANG': 'en_US.UTF-8', 05:02:47 INFO - 'LANGUAGE': 'en_US:en', 05:02:47 INFO - 'LOGNAME': 'cltbld', 05:02:47 INFO - 'MAIL': '/var/mail/cltbld', 05:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:47 INFO - 'MOZ_NO_REMOTE': '1', 05:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:47 INFO - 'NO_EM_RESTART': '1', 05:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:47 INFO - 'SHELL': '/bin/bash', 05:02:47 INFO - 'SHLVL': '1', 05:02:47 INFO - 'TERM': 'linux', 05:02:47 INFO - 'TMOUT': '86400', 05:02:47 INFO - 'USER': 'cltbld', 05:02:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:47 INFO - '_': '/tools/buildbot/bin/python'} 05:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:02:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:49 INFO - Downloading docopt-0.6.1.tar.gz 05:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:49 INFO - Running setup.py install for blobuploader 05:02:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:02:49 INFO - Running setup.py install for requests 05:02:50 INFO - Running setup.py install for docopt 05:02:50 INFO - Successfully installed blobuploader requests docopt 05:02:50 INFO - Cleaning up... 05:02:50 INFO - Return code: 0 05:02:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:02:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:50 INFO - Using env: {'DISPLAY': ':0', 05:02:50 INFO - 'HOME': '/home/cltbld', 05:02:50 INFO - 'LANG': 'en_US.UTF-8', 05:02:50 INFO - 'LANGUAGE': 'en_US:en', 05:02:50 INFO - 'LOGNAME': 'cltbld', 05:02:50 INFO - 'MAIL': '/var/mail/cltbld', 05:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:50 INFO - 'MOZ_NO_REMOTE': '1', 05:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:50 INFO - 'NO_EM_RESTART': '1', 05:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:50 INFO - 'SHELL': '/bin/bash', 05:02:50 INFO - 'SHLVL': '1', 05:02:50 INFO - 'TERM': 'linux', 05:02:50 INFO - 'TMOUT': '86400', 05:02:50 INFO - 'USER': 'cltbld', 05:02:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:50 INFO - '_': '/tools/buildbot/bin/python'} 05:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:50 INFO - Running setup.py (path:/tmp/pip-GddS06-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:50 INFO - Running setup.py (path:/tmp/pip-Tz542q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:50 INFO - Running setup.py (path:/tmp/pip-7DSvGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:50 INFO - Running setup.py (path:/tmp/pip-Va2SCr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:51 INFO - Running setup.py (path:/tmp/pip-4tTeNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:51 INFO - Running setup.py (path:/tmp/pip-JiGI9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:51 INFO - Running setup.py (path:/tmp/pip-FJK1ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:51 INFO - Running setup.py (path:/tmp/pip-A5PhQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:51 INFO - Running setup.py (path:/tmp/pip-epFIGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:51 INFO - Running setup.py (path:/tmp/pip-bh8BDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:51 INFO - Running setup.py (path:/tmp/pip-h_WMJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:51 INFO - Running setup.py (path:/tmp/pip-w8T48I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:51 INFO - Running setup.py (path:/tmp/pip-YGDzg0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:51 INFO - Running setup.py (path:/tmp/pip-Ei81EE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:51 INFO - Running setup.py (path:/tmp/pip-4vh6to-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:51 INFO - Running setup.py (path:/tmp/pip-cdHAEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:51 INFO - Running setup.py (path:/tmp/pip-T1BUbT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:51 INFO - Running setup.py install for manifestparser 05:02:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Running setup.py install for mozcrash 05:02:52 INFO - Running setup.py install for mozdebug 05:02:52 INFO - Running setup.py install for mozdevice 05:02:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Running setup.py install for mozfile 05:02:52 INFO - Running setup.py install for mozhttpd 05:02:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Running setup.py install for mozinfo 05:02:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Running setup.py install for mozInstall 05:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Running setup.py install for mozleak 05:02:52 INFO - Running setup.py install for mozlog 05:02:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:02:52 INFO - Running setup.py install for moznetwork 05:02:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:02:53 INFO - Running setup.py install for mozprocess 05:02:53 INFO - Running setup.py install for mozprofile 05:02:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:02:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:02:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:02:53 INFO - Running setup.py install for mozrunner 05:02:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:02:53 INFO - Running setup.py install for mozscreenshot 05:02:53 INFO - Running setup.py install for moztest 05:02:53 INFO - Running setup.py install for mozversion 05:02:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:53 INFO - Cleaning up... 05:02:53 INFO - Return code: 0 05:02:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:02:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:53 INFO - Using env: {'DISPLAY': ':0', 05:02:53 INFO - 'HOME': '/home/cltbld', 05:02:53 INFO - 'LANG': 'en_US.UTF-8', 05:02:53 INFO - 'LANGUAGE': 'en_US:en', 05:02:53 INFO - 'LOGNAME': 'cltbld', 05:02:53 INFO - 'MAIL': '/var/mail/cltbld', 05:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:53 INFO - 'MOZ_NO_REMOTE': '1', 05:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:53 INFO - 'NO_EM_RESTART': '1', 05:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:53 INFO - 'SHELL': '/bin/bash', 05:02:53 INFO - 'SHLVL': '1', 05:02:53 INFO - 'TERM': 'linux', 05:02:53 INFO - 'TMOUT': '86400', 05:02:53 INFO - 'USER': 'cltbld', 05:02:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:53 INFO - '_': '/tools/buildbot/bin/python'} 05:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:53 INFO - Running setup.py (path:/tmp/pip-bicugf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:54 INFO - Running setup.py (path:/tmp/pip-H0Rvf7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:54 INFO - Running setup.py (path:/tmp/pip-Rvn4iq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:54 INFO - Running setup.py (path:/tmp/pip-LqFYbx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:54 INFO - Running setup.py (path:/tmp/pip-H8Nvau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:54 INFO - Running setup.py (path:/tmp/pip-Gn02Q1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:54 INFO - Running setup.py (path:/tmp/pip-wWme6e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:54 INFO - Running setup.py (path:/tmp/pip-hBVl8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:54 INFO - Running setup.py (path:/tmp/pip-sjudyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:54 INFO - Running setup.py (path:/tmp/pip-GP9R9b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:54 INFO - Running setup.py (path:/tmp/pip-33gRl4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:54 INFO - Running setup.py (path:/tmp/pip-czP3TQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:54 INFO - Running setup.py (path:/tmp/pip-ETMfL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:54 INFO - Running setup.py (path:/tmp/pip-5ZZ82S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:54 INFO - Running setup.py (path:/tmp/pip-MpjBtP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:55 INFO - Running setup.py (path:/tmp/pip-GHLyI9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:02:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:55 INFO - Running setup.py (path:/tmp/pip-AZ0WDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:56 INFO - Downloading blessings-1.6.tar.gz 05:02:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:57 INFO - Installing collected packages: blessings 05:02:57 INFO - Running setup.py install for blessings 05:02:57 INFO - Successfully installed blessings 05:02:57 INFO - Cleaning up... 05:02:57 INFO - Return code: 0 05:02:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:02:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:02:57 INFO - Reading from file tmpfile_stdout 05:02:57 INFO - Current package versions: 05:02:57 INFO - argparse == 1.2.1 05:02:57 INFO - blessings == 1.6 05:02:57 INFO - blobuploader == 1.2.4 05:02:57 INFO - docopt == 0.6.1 05:02:57 INFO - manifestparser == 1.1 05:02:57 INFO - mozInstall == 1.12 05:02:57 INFO - mozcrash == 0.16 05:02:57 INFO - mozdebug == 0.1 05:02:57 INFO - mozdevice == 0.48 05:02:57 INFO - mozfile == 1.2 05:02:57 INFO - mozhttpd == 0.7 05:02:57 INFO - mozinfo == 0.9 05:02:57 INFO - mozleak == 0.1 05:02:57 INFO - mozlog == 3.1 05:02:57 INFO - moznetwork == 0.27 05:02:57 INFO - mozprocess == 0.22 05:02:57 INFO - mozprofile == 0.28 05:02:57 INFO - mozrunner == 6.11 05:02:57 INFO - mozscreenshot == 0.1 05:02:57 INFO - mozsystemmonitor == 0.0 05:02:57 INFO - moztest == 0.7 05:02:57 INFO - mozversion == 1.4 05:02:57 INFO - psutil == 3.1.1 05:02:57 INFO - requests == 1.2.3 05:02:57 INFO - wsgiref == 0.1.2 05:02:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:57 INFO - Using env: {'DISPLAY': ':0', 05:02:57 INFO - 'HOME': '/home/cltbld', 05:02:57 INFO - 'LANG': 'en_US.UTF-8', 05:02:57 INFO - 'LANGUAGE': 'en_US:en', 05:02:57 INFO - 'LOGNAME': 'cltbld', 05:02:57 INFO - 'MAIL': '/var/mail/cltbld', 05:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:57 INFO - 'MOZ_NO_REMOTE': '1', 05:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:57 INFO - 'NO_EM_RESTART': '1', 05:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:57 INFO - 'SHELL': '/bin/bash', 05:02:57 INFO - 'SHLVL': '1', 05:02:57 INFO - 'TERM': 'linux', 05:02:57 INFO - 'TMOUT': '86400', 05:02:57 INFO - 'USER': 'cltbld', 05:02:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:57 INFO - '_': '/tools/buildbot/bin/python'} 05:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:02:57 INFO - Cleaning up... 05:02:57 INFO - Return code: 0 05:02:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:02:57 INFO - Using env: {'DISPLAY': ':0', 05:02:57 INFO - 'HOME': '/home/cltbld', 05:02:57 INFO - 'LANG': 'en_US.UTF-8', 05:02:57 INFO - 'LANGUAGE': 'en_US:en', 05:02:57 INFO - 'LOGNAME': 'cltbld', 05:02:57 INFO - 'MAIL': '/var/mail/cltbld', 05:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:57 INFO - 'MOZ_NO_REMOTE': '1', 05:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:57 INFO - 'NO_EM_RESTART': '1', 05:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:02:57 INFO - 'SHELL': '/bin/bash', 05:02:57 INFO - 'SHLVL': '1', 05:02:57 INFO - 'TERM': 'linux', 05:02:57 INFO - 'TMOUT': '86400', 05:02:57 INFO - 'USER': 'cltbld', 05:02:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:57 INFO - '_': '/tools/buildbot/bin/python'} 05:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:57 INFO - Downloading/unpacking jsonschema 05:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:59 INFO - Downloading/unpacking functools32 (from jsonschema) 05:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:59 INFO - warning: no files found matching '*.txt' 05:02:59 INFO - no previously-included directories found matching 'build' 05:02:59 INFO - no previously-included directories found matching 'dist' 05:02:59 INFO - no previously-included directories found matching '.git*' 05:02:59 INFO - Installing collected packages: jsonschema, functools32 05:02:59 INFO - Running setup.py install for functools32 05:03:00 INFO - warning: no files found matching '*.txt' 05:03:00 INFO - no previously-included directories found matching 'build' 05:03:00 INFO - no previously-included directories found matching 'dist' 05:03:00 INFO - no previously-included directories found matching '.git*' 05:03:00 INFO - Successfully installed jsonschema functools32 05:03:00 INFO - Cleaning up... 05:03:00 INFO - Return code: 0 05:03:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff785e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:03:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:03:00 INFO - Using env: {'DISPLAY': ':0', 05:03:00 INFO - 'HOME': '/home/cltbld', 05:03:00 INFO - 'LANG': 'en_US.UTF-8', 05:03:00 INFO - 'LANGUAGE': 'en_US:en', 05:03:00 INFO - 'LOGNAME': 'cltbld', 05:03:00 INFO - 'MAIL': '/var/mail/cltbld', 05:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:00 INFO - 'MOZ_NO_REMOTE': '1', 05:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:00 INFO - 'NO_EM_RESTART': '1', 05:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:00 INFO - 'SHELL': '/bin/bash', 05:03:00 INFO - 'SHLVL': '1', 05:03:00 INFO - 'TERM': 'linux', 05:03:00 INFO - 'TMOUT': '86400', 05:03:00 INFO - 'USER': 'cltbld', 05:03:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:00 INFO - '_': '/tools/buildbot/bin/python'} 05:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:00 INFO - Downloading/unpacking flake8 05:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:03:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:03:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:03:02 INFO - no previously-included directories found matching 'docs/_build' 05:03:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:03:02 INFO - Running setup.py install for pep8 05:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:03:02 INFO - no previously-included directories found matching 'docs/_build' 05:03:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:03:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:03:02 INFO - Cleaning up... 05:03:03 INFO - Return code: 0 05:03:03 INFO - Running post-action listener: _resource_record_post_action 05:03:03 INFO - Running post-action listener: _start_resource_monitoring 05:03:03 INFO - Starting resource monitoring. 05:03:03 INFO - ##### 05:03:03 INFO - ##### Running install step. 05:03:03 INFO - ##### 05:03:03 INFO - Running pre-action listener: _resource_record_pre_action 05:03:03 INFO - Running main action method: install 05:03:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:03:03 INFO - Reading from file tmpfile_stdout 05:03:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:03:03 INFO - Reading from file tmpfile_stdout 05:03:03 INFO - Output received: 05:03:03 INFO - Usage: mozinstall [options] installer 05:03:03 INFO - Options: 05:03:03 INFO - -h, --help show this help message and exit 05:03:03 INFO - -d DEST, --destination=DEST 05:03:03 INFO - Directory to install application into. [default: 05:03:03 INFO - "/builds/slave/test-pgo"] 05:03:03 INFO - --app=APP Application being installed. [default: firefox] 05:03:03 INFO - mkdir: /builds/slave/test-pgo/build/application 05:03:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:03:19 INFO - Reading from file tmpfile_stdout 05:03:19 INFO - Output received: 05:03:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:03:19 INFO - Running post-action listener: _resource_record_post_action 05:03:19 INFO - ##### 05:03:19 INFO - ##### Running run-tests step. 05:03:19 INFO - ##### 05:03:19 INFO - Running pre-action listener: _resource_record_pre_action 05:03:19 INFO - Running main action method: run_tests 05:03:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:03:19 INFO - Python 2.7.3 05:03:19 INFO - Return code: 0 05:03:19 INFO - grabbing minidump binary from tooltool 05:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14147c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:03:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:03:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:03:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:19 INFO - Return code: 0 05:03:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:03:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:03:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:03:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:03:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:03:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:03:20 INFO - Return code: 0 05:03:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:03:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:03:20 INFO - Using env: {'DISPLAY': ':0', 05:03:20 INFO - 'HOME': '/home/cltbld', 05:03:20 INFO - 'LANG': 'en_US.UTF-8', 05:03:20 INFO - 'LANGUAGE': 'en_US:en', 05:03:20 INFO - 'LOGNAME': 'cltbld', 05:03:20 INFO - 'MAIL': '/var/mail/cltbld', 05:03:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:03:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:20 INFO - 'MOZ_NO_REMOTE': '1', 05:03:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:20 INFO - 'NO_EM_RESTART': '1', 05:03:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:03:20 INFO - 'SHELL': '/bin/bash', 05:03:20 INFO - 'SHLVL': '1', 05:03:20 INFO - 'TERM': 'linux', 05:03:20 INFO - 'TMOUT': '86400', 05:03:20 INFO - 'USER': 'cltbld', 05:03:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034', 05:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:20 INFO - '_': '/tools/buildbot/bin/python'} 05:03:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:03:20 INFO - mozversion application_buildid: 20160211023003 05:03:20 INFO - mozversion application_changeset: ed1086f28ad16013658981a24fbd154913632710 05:03:20 INFO - mozversion application_display_name: Nightly 05:03:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:20 INFO - mozversion application_name: Firefox 05:03:20 INFO - mozversion application_remotingname: firefox 05:03:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:03:20 INFO - mozversion application_vendor: Mozilla 05:03:20 INFO - mozversion application_version: 47.0a1 05:03:20 INFO - mozversion platform_buildid: 20160211023003 05:03:20 INFO - mozversion platform_changeset: ed1086f28ad16013658981a24fbd154913632710 05:03:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:03:20 INFO - mozversion platform_version: 47.0a1 05:03:20 INFO - using testdate: 1455195800 05:03:20 INFO - actual date: 1455195800 05:03:20 INFO - starting webserver on 'localhost:33530' 05:03:20 INFO - SUITE-START | Running 2 tests 05:03:20 INFO - TEST-START | dromaeo_css 05:03:20 INFO - operating with platform_type : linux_ 05:03:20 INFO - Initialising browser for dromaeo_css test... 05:03:20 INFO - TEST-INFO | started process 20429 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD2uXVO/profile http://localhost:33530/getInfo.html) 05:03:25 INFO - PROCESS | 20429 | __metrics Screen width/height:1600/1200 05:03:25 INFO - PROCESS | 20429 | colorDepth:24 05:03:25 INFO - PROCESS | 20429 | Browser inner width/height: 1024/697 05:03:25 INFO - PROCESS | 20429 | __metrics 05:03:25 INFO - PROCESS | 20429 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:26 INFO - TEST-INFO | 20429: exit 0 05:03:26 INFO - Browser initialized. 05:03:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:26 INFO - TEST-INFO | started process 20518 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD2uXVO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:38 INFO - PROCESS | 20518 | RSS: Main: 153141248 05:03:38 INFO - PROCESS | 20518 | 05:04:29 INFO - PROCESS | 20518 | 1455195869851 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:06:38 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33530/tests/dromaeo/cssquery-ext.html) 05:06:39 INFO - PROCESS | 20518 | RSS: Main: 267243520 05:06:39 INFO - PROCESS | 20518 | 05:09:41 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-ext.html (next: http://localhost:33530/tests/dromaeo/cssquery-jquery.html) 05:09:42 INFO - PROCESS | 20518 | RSS: Main: 241676288 05:09:42 INFO - PROCESS | 20518 | 05:12:44 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33530/tests/dromaeo/cssquery-mootools.html) 05:12:45 INFO - PROCESS | 20518 | RSS: Main: 239722496 05:12:45 INFO - PROCESS | 20518 | 05:15:47 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33530/tests/dromaeo/cssquery-prototype.html) 05:15:47 INFO - PROCESS | 20518 | RSS: Main: 221069312 05:15:47 INFO - PROCESS | 20518 | 05:18:50 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33530/tests/dromaeo/cssquery-yui.html) 05:18:50 INFO - PROCESS | 20518 | RSS: Main: 221122560 05:18:50 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | Cycle 1(1): loaded http://localhost:33530/tests/dromaeo/cssquery-yui.html (next: http://localhost:33530/tests/dromaeo/cssquery-dojo.html) 05:21:53 INFO - PROCESS | 20518 | RSS: Main: 269144064 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | __start_tp_report 05:21:53 INFO - PROCESS | 20518 | _x_x_mozilla_page_load 05:21:53 INFO - PROCESS | 20518 | _x_x_mozilla_page_load_details 05:21:53 INFO - PROCESS | 20518 | |i|pagename|runs| 05:21:53 INFO - PROCESS | 20518 | |0;dojo.html;3132.373525294941;3173.032225171322;3218.8229647369385;3221.3235220603674;3257.5928008998876;5170.715610641413;5251.684898906064;5290.894182116355;5309.973450132748;5357.357117145938;5289.894202115965;5329.840104796853;5366.543843773275;5366.570674346052;5371.704556249405;4702.153612349775;4765.046990601885;4819.5180481951875;4874.415070191582;4876.049170411771;4718.268668356411;4934.950650493503;4952.975235123819;4977.875553111183;4979.427365852937;4757.26262429324;4783.880402989918;4834.226523756182;4843.709377437365;4867.269909513566;4793.784279707422;4803.3995750531185;4806.663533552618;4819.542143496362;4826.7827947742435;4668.976655116737;4794.880127996793;4803.3995750531185;4810.302506136625;4870.902581948341;5085.898282034339;5099.286099946011;5118.974405127988;5119.872003199913;5128.076946149691;5645.2096706461125;5647.689377084259;5648.519875810561;5686.9715651421475;5700.7719691212305;5583.832485025456;5603.019471592495;5615.943840561583;5626.521745651625;5681.062624666966;5336.332958380202;5359.464053594648;5363.731813409314;5366.329208848933;5367.1680889462195;5688.8862222755315;5774.04728219839;5831.067029275296;5831.271091113611;5890.322612899571;5638.069718496402;5679.829605111853;5694.402087780723;5696.8860622787315;5747.224124743189;5628.212050312959;5651.519620832193;5657.20799088128;5658.943410565842;5661.518770904519;5528.198411230349;5597.468240517144;5608.747606357723;5611.130274807411;5611.494965453047;5615.943840561624;5618.775248989995;5619.353774315924;5627.268455100811;5660.433956604306;4323.848665296699;4324.805383757738;4328.069465065026;4328.523862375137;4371.30059190528;3795.35478968576;3870.4581358609817;3895.8441662333757;3902.8829135125993;3927.096767743435;5275.050490911673;5299.788008479618;5306.163021868787;5319.760610772524;5323.148296272655;5542.473465020817;5681.857953551194;5699.316082070095;5701.771929122871;5711.485966263056;5197.350331208599;5224.895502089937;5297.735113244323;5310.92033619496;5344.545713614309;4805.687630304019;4826.107170173529;4833.637477189154;4846.103470857903;4875.171220892456;5758.107493338539;5879.5002424794375;5898.793542226002;5903.616264942765;5910.527157827363;5656.095024796013;5713.800016999551;5733.111367738007;5734.541236701138;5777.364489906191;5901.3213480448585;5950;5952.0476723724;5956.493698035542;5957.344692083954;5417.566594672496;5498.257735205696;5617.354004289559;5671.8865622688145;5683.204351390891;5647.604667673223;5676.7161641918565;5685.204071430086;5688.232088668143;5715.257016587817;5512.924979628934;5517.834464966058;5524.8342549723575;5529.115341545334;5532.585056120726;5398.055340315507;5489.64317319373;5493.862653433696;5553.72231388437;5637.577181711306;5477.178423236546;5493.533049690821;5500.779968801203;5504.6421982571;5505.394406615189;5573.331200255995;5594.748236329457;5605.243292155506;5612.298462692163;5658.801941932177;5366.838994830161;5402.297701298806;5446.782128714807;5486.286782718221;5501.3948465667945 05:21:53 INFO - PROCESS | 20518 | |1;ext.html;522.7778194267438;542.6689719271245;550.4440515079768;564.2580007290413;584.4856526256893;27915.162545123654;28368.290792730193;28372.148835534914;28380.574291385645;35670.2865942681;38399.77602463734;38711.61288387115;38883;38887.805560972156;38963.24665390064;8485.406021578476;8705.651773929067;8714.738557843275;8716.08481109484;8716.128387161265;8500.234978851902;8592.570371481432;8604.26863716585;8615.483071015728;8627.180417860325;8623.267022303111;8922.420042697237;8944.686935957243;8947.105289471034;8953;8802.03177650458;8876.112388761072;8876.156765107304;8877.866831997526;8880.8667869982;8738.563071846382;8914.108589141098;8918.55407229636;8919.73240802777;8924.286057115416;40017.79991100055;40314.19371612581;40356;40400.59599403998;40405;3305.5537502437105;3316.436205845012;3352.2960178362573;3375.831208439593;3418.8632454701783;29032.564511532342;29157.41685166285;29512.557311640343;30359;30534.236644083852;3920.3923391874305;3941.5467221269632;4030.5364883038533;4067.28822456069;4184.246835569596;243538;251010;252416;252673;252832;42854;43368.78315608402;43371.783141084095;55746;56659;43226.783866081096;43293.78353108277;43402;43571.78214108909;43599;14169.85830141706;14230.43465218825;14385.64035899111;14412.711745765026;14413.42346306157;12142.271463712206;12370.072244581692;12405.193662411913;12467.438965246585;12468.875311246953;14515.693587576958;14571.344289506998;14740;15055.54833355001;15106.622334441507;6095.664738439428;6147.692615369214;6154.569180157436;6157.107219453154;6199.101130336076;908.3823000359687;956.8134213828237;974.5370948799264;1087.7933192693363;1095.2169199022737;27041.729582704316;27730.3067423312;28050.579241311396;28191.71808281891;28300.71699283022;1087.9347239165675;1108.41808050774;1179.4279774309452;1220.9145359824904;1220.9987809995896;15516.689666206612;15804.604884877741;16069.196540173178;16149.354025838835;16164;342955;352850;353012;353209;353983.84064637125;54720.45279547233;55215.447845521834;55225.171622425696;55292.170617440774;55334.446655533735;1232.9013678905667;1357.735241627893;1424.4587056918306;1442.4158215922569;1461.0941216445658;29371.853140734158;32457;33255.50116748202;33985;34930.65069349376;50452.49547504625;51060;51105.74447127741;51117.48882511276;51197.744011279705;275026;277270;278001;280173;282163;41764;42796.144077117664;42945.3558196621;42983.570164297955;43918.560814392724;40743.91761573601;42998.14003719971;43305.56694433141;43956.34065489084;44487.55512444834;36195.819020904724;36639;36937.44593831148;37091.07272318214;37823.243535129695;37017.444738328406;37115.25769484649;37564.43653345147;38137;38221.61778382181;37872.242555148194;37949.62050379571;37981.620183798914;37992.620073798906;39685.404718928665;29109.85445072761;29552.852235739545;31236;31857.20356991001;33788.32423351568;26110;26329.73670263273;26406.867965660047;26438;26593.867030664722 05:21:53 INFO - PROCESS | 20518 | |2;jquery.html;366.43751840924176;366.49423795162687;367.5607648859613;371.0741699459848;374.7133442916168;13633.250171240577;13753.724925501483;16336.591585210375;17250.741238881412;18216.817831821696;14210.786838197435;15039.699206015874;15090;15109.471168509104;16050.27773750181;5139.974300128494;5293.04725149473;5308.044551980642;5314.973425132869;5328.973355133219;3976.542697589771;5250.159974404077;5298.6555873868265;5614.691191984439;5862.970685146568;5631.60578759487;5787.710614469281;5838.591298609099;5841.386654401291;5841.561882858781;5832.329282132567;5838.299404071496;5839.941600583982;5841.503472204868;5845.678487683176;4972.403311602631;5057.873553161164;5068.239764035387;5098.082345177866;5098.643094983353;20152.49618759528;20259.189632414687;20291.188352465884;20314.18743250283;20428.182872685076;1915.990420047891;2076.885771282594;2353.658719485682;2382.106709983756;2858.2568532181576;9170;9467.573959171854;9666.130048295618;9681.806363872754;12256.387180640932;1766.9823301766946;1806.7289906513997;1865.5056410051347;1918.3094086128983;1926.1428664244418;52201.73899130518;57920;59351.70324148352;59852;60296.69851650714;9777.755556111011;10055.547500362502;10078.445685487222;10087.344322619154;10117;13081.738365232643;13244.73510529784;13246.337683115806;13254.204747715168;13254.602361929157;7513.962430187814;7707;7711.0746710395115;7754.526639938506;7755.612219389008;7522.623868806538;7607.16321204667;7732.6520306586335;7740.922590774133;7769.417293702995;4486.59620634138;4490.820367185276;4493.955060449419;4519.209138400766;4527.615152712056;1706.1725063344268;1751.7547543343687;1771.3268957796213;1773.9379121730935;1776.111944027986;447.78953891670864;925.9722208333761;937.6905621145006;946.536197263336;948.6252930092575;8803.911960880438;10612;10860.565577376974;11053.778924421467;11215.831762523569;486.3822944860008;501.22560643805406;509.630517874538;512.4619149892598;517.0331480132102;6061.363556826558;6366.745330186741;6393.326622748885;6558.540902136805;6570.408663220333;459316;468751;505153;512792;519298;65919;73183;74744.62627686826;75260;76348;1133.6769020829024;1181.8345431639577;1182.8817118288102;1228.4778968938165;1256.7109564799964;14750.926245368704;16008.119553424207;16213.351465941701;16375.017498949624;16513.091779952218;30752.231194220323;31363.05910822679;32686.83656581702;33571.66428335783;35211;42561.361579575714;43135;43639.345409819514;44080.77959610181;44494;7177.712891484282;7370.705171793283;7383.778486645409;7453.40372770188;7487.625618718933;8074.959625201836;9595;10939.277570506712;11478.655640330804;11683.532658693557;9921.156701680438;10394.636187733393;10581.523831427758;10647.361158330525;10693.411862347646;10449.216308777024;10452.68641940743;10582.8412573813;10612.416317102634;10739.409332486475;10307.123894468754;10492.422916739653;10570.154387648816;10808.297460665031;10887.292325998786;7581;7614.390848731978;7616.466847320635;7626.122995855548;7626.694932202649;10395.428251445941;10648.254622176373;10718.088962437969;10804.891951080388;10961.397123157984 05:21:53 INFO - PROCESS | 20518 | |3;mootools.html;1254.3101294288142;1261.5836773864619;1292.160095937641;1303.0617955072348;1393.574959637311;7018.929810701898;7905.84188316234;8015.679372825095;8023.157568455315;8028.638711257993;7877.133515313311;8056.8388632227325;8059.314958228543;8061.717839875606;8067;2055.177928828473;2101.4011006863047;2327.057541695616;2373.181252467896;2392.569337519246;2375.9762402375927;2383.988080059606;2384.082128380577;2386.653935179398;2387.343480542856;2318.547883162784;2384.248961577098;2385.7733515316017;2385.8926348314367;2388.9880550597222;2034.5117171878717;2312.5952958232324;2364.3025307534317;2390.8206884483734;2397.6043952747777;2341.1571834139695;2356.36378177891;2380.238323736405;2387.6179811230295;2390.306811024801;7697.076350837935;7723.227677232288;7741.496802707806;7758.6896524138965;7778.455508114434;4909.509049095098;5004.849854504334;5035.169197082477;5041.521055499722;5042.268871013719;3291.1772056985756;3323.833808309575;3384.5938487381427;3452.2922800825772;3465.636108208627;1164.714644912002;1174.183942160199;1180.728432460539;1189.6371606659966;1242.4471110355896;11381.260218085881;11398.202125851194;11437.370944598044;11440.771184576344;11451.31292122467;4574.885627859264;4595.1269258841385;4651.837185698484;4663.51033141522;4666.346711460398;9799.608015679436;9800.215982721365;9802.852957205647;9816.411015339103;9823.361481503822;5146.202338637517;5151.793928242903;5169.121249387613;5169.870753231199;5171.4052883918075;4649;4696.953030469652;4703.529647035269;4705.176594096088;4706.058788242297;3809.0858194033785;3891.1828516011956;3895.0651843557343;3902.707296952683;3930.3514920037874;1222.2971791220084;1223.718544734716;1229.1150371732338;1233.2600439736086;1239.7892358299111;1304.6281809684385;1304.7977563477486;1307.9346032698327;1311.8097875807955;1348.5347555093476;7678.462507624525;7680.385569154454;7848.56832874186;7855;7857.764267071997;506.4252073896081;516.6925679220858;517.6867994863129;517.7049082023286;526.5471694342939;5767.711614419262;5775.740091695884;5789.726260222744;5821.476067153892;5824.5631577631;9296.814063718688;9955.402675839472;10128.088472037405;10133.189344852393;10168.593256269667;9894.06643257939;10000.749831288047;10006.949965250127;10020.198384129251;10029.648962286285;7522.285382888617;7581.090269167735;7634.351080158138;7675.61621918913;7687.192844751333;6979.371856532734;7430.071241094864;7432;7435.367993720594;7438.851222975619;8556.871646925176;8568.657253709782;8617.439866408664;8633.481991080555;8731.432456890281;8793.868091978498;9006.729798106067;9013;9029.142231487998;9126.908730912872;7097.538659987084;7229.927700722926;7232.168300645493;7234.276572342724;7237.3486386225495;7431.108267007994;7487.887681684888;7551.207123252199;7721.073471183494;7726.884096738666;6413.679316034273;7224.89162662571;7259.382952449101;7291.744788932362;7370.520916140434;6570.047343135314;7054.823629409306;7119.608421536658;7138.607376594129;7274.527155734861;7165.8925116122255;7222.494425390172;7232.385247253832;7232.963835180791;7240.203577606354;6622.403983641495;6646.634435105922;6651.73393064272;6660.367265109807;6670.066190733204;6603.075569420189;6643.1031810704935;6645.634490103091;6769.559978601375;6775.661216939035 05:21:53 INFO - PROCESS | 20518 | |4;prototype.html;340.96590340965906;349.2107836289984;350.4095598915826;353.4962678183588;357.41919381005863;5836.5914385993;5837.182794408781;5887.8822423551555;5887.911681324773;5907.704614769265;5800.4489573490555;5810.622309549876;5814.854628634275;5825.796097136601;5835.124731290298;4465.598096171344;4542.886427839314;4560.703554268978;4569.771511424432;4571.428571428572;4557.02024064826;4562.338460923181;4568.634509239253;4575.130725162225;4577.793999270024;4528.071745292207;4536.047430039679;4537.024539723959;4539.251023581121;4539.319102134673;4295.699301048928;4368.49762277339;4408.250597398418;4495.168393847116;4518;3945.5462621798574;3957.564667886559;3969.3053715599945;3988.12261302513;3997.1805779815068;5318.1225097858805;5512.283403157564;5540.279763630702;5544.417836127189;5570.442955704397;5086.669366491166;5224.738763061831;5225.790968361299;5231.110711179109;5239.345081864767;6148.569600127993;6173.969130154321;6174.660393678346;6182.536309776785;6187.783427580058;4461.21928662486;4462.933056004163;4463.620592249663;4466.82132714691;4467.888302792424;6274.964630835907;6388.552801303864;6423.197100362455;6430.967845160744;6469.159009328804;4572.08558288337;4573.794179261941;4575.816967321336;4576.290674945389;4582.679212455163;4607.654425918069;4616.146012987608;4621.376114224604;4621.537846215351;4629.166749985035;5261.921071183935;5271.182966640177;5272.103742363807;5272.894542109137;5285.55072818807;6075.817725468155;6210.5652604317265;6218.2538095427935;6219.253689557192;6226.283977342573;1608.404890190637;1632.3552196882165;1632.6653036127566;1634.8855580109278;1635.607454210981;1106.4246591772394;1113.1095123900848;1115.1524841120645;1118.981726628764;1141.6917432293235;5784.161296611967;5794.275715535558;5797.391273916262;5803.622764520293;5884.08796636522;6391.328910464427;6391.872162556816;6392.808215753442;6405.167328247298;6407.263164736115;5782.595218334676;5899;5914;5914.9704251479325;5915.7633694652595;3404.880829170967;3446.5691788526433;3455.1707590178175;3458.1181798641187;3458.4466485362723;6580.8354791130605;6607.405333520006;6616.371444712745;6622.4039836413995;6630.474990752154;6240.5319601030105;6392.360763923663;6489.448396886223;6491.480681545465;6569.540132190701;6703.195616525853;6707;6708.060871477997;6718.160229971254;6722.218612067903;6408.935910640834;6428.742850285937;6436.485081193587;6438.581492202992;6439.7424103035355;6219.595726277777;6244.220136552399;6344.365563443619;6358.109864619049;6376.74493020274;6707.463402927657;6708.161479815023;6711.395974362331;6712.83217919556;6716.865662686621;4604.355390245435;4606.907861842677;4609.930851037304;4610.446746390455;4613.5847773700525;6256.906146407717;6473.611583305017;6473.676316184078;6488.902666459912;6496.7726129585235;6298.748050077946;6302.180716506825;6302.905456418066;6306.527010474141;6308;6229.345918678474;6249.718762655601;6284.905726414016;6290.874182516232;6292.182016337847;6060.606060606046;6188.721507532082;6190.102435146969;6192;6195.96902015487;6314.4632706218645;6316.242050953915;6316.684165791784;6324;6326.652034137983;6138.600990935575;6170.012797952306;6171;6175.722092505758;6182.196314479089 05:21:53 INFO - PROCESS | 20518 | |5;yui.html;721.4661150748444;773.8181527341075;794.7059587952458;798.173890023825;810.4893916832394;13447.865521344784;13683.589492315234;13713.31433428327;13728.382222799974;13748.725025499496;12386.07104467164;12731.554395596157;12752.489900403973;12766.170198937085;12772.616821495347;675.0684056002709;684.9760258390958;818.4271010292819;833.5998720614109;834.1491678487939;822.5681517203457;827.4538804389105;827.4745536584282;827.8302947895667;829.2992421403934;710.1726488640727;834.6911642692182;875.3916028360292;876.6843936182969;876.8027193881389;838.0404436919754;838.4005436113177;839.215333663027;839.7061028639988;851.9787005324855;617.4658920034183;619.4239357397619;619.8264485943943;622.9501639868799;623.688155922039;12948.482060717653;12950.54673086447;13006.479740810357;13023.739525209538;13054;12344.38278086092;12759.872401275961;12975.87024129756;13108.672283192996;13210.66973325665;10512.211584131144;10522.84215736757;10528.105111065568;10558.78882422355;10684.51919663617;3595.442706380489;3645.76302540334;3647.434647629622;3647.544056992876;3660.084978755311;48130.27804582934;48198;48248.51751482475;48258.27612585814;48283.99999999965;9330.95334523323;9646.758831029281;10195.452495080252;10478.476076196159;10699.037086662238;18189.27242910295;18233.7264941026;18238.63522729538;18244.543886402946;18265.45203643893;7738.651760670783;7749.92250077492;7816.921830781619;7878.684852605831;7880.487768295043;4122.443470131494;4131.793410329472;4168.228877657643;4244.236037513216;4286.935695964563;3207.342494788609;3207.9037628870706;3213.7268332191557;3230.644629090798;3244.221386867182;550.2708910693267;569.163329905039;577.6620676904058;585.411661280419;589.6167491130714;523.5133117690968;659.5877576514679;684.5687217053224;687.8830598798216;696.7004188199123;8770.298376129895;9021.188093071654;9227.76930576741;9774.706758797247;9882.555285012191;560.0099292540648;703.781827633425;718.9748358807417;722.9855402891912;763.9006929099181;3925.4896863407575;4008.5390180129075;4111.301078816608;4210.136921930997;4297.162053399619;50334.49665503371;51303.743481282356;51571;51648;51827;46746;46944;47147.76426117916;47462.76268618635;47715.76142119267;42291;42470.150596987885;42659.36010959838;42699.7865010673;42801.35797963033;8421.852427630914;8455.788605284917;8569.657213711382;8636;8643.91356086431;32088.518672219467;32295;32474.02577922666;32630;32739.672603273662;36891.446628301135;37240.813795930844;37515.81242093772;41539.79230103951;41619.167616648105;10045.347052441568;10047.145992590711;10189.337693049929;10511.316764410289;10606.946965265124;10876.836847447137;11012.119030477383;11014.559417623206;11190.608328708457;11256.83114753263;10136.341137826017;10262.127719143957;10440.269181157246;10675.092617127631;10814.945925270324;10149.898501014895;10187.949060254652;10311;10486.528106235086;10696.946515267375;10308.381497110197;10410.635627752992;10450.372977621062;10561.313514621525;10697.732556686145;8560.91439085601;8584.399092063495;8968.910310897068;9135.90864091377;9238.214751746176;8913.777155570902;8958;8959.1936725695;9041.547922603975;9397.436153830791 05:21:53 INFO - PROCESS | 20518 | __end_tp_report 05:21:53 INFO - PROCESS | 20518 | __start_cc_report 05:21:53 INFO - PROCESS | 20518 | _x_x_mozilla_cycle_collect,953 05:21:53 INFO - PROCESS | 20518 | __end_cc_report 05:21:53 INFO - PROCESS | 20518 | __startTimestamp1455196913791__endTimestamp 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | ------- Summary: start ------- 05:21:53 INFO - PROCESS | 20518 | Number of tests: 6 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | [#0] dojo.html Cycles:165 Average:5265.46 Median:5489.64 stddev:585.95 (10.7%) stddev-sans-first:563.35 05:21:53 INFO - PROCESS | 20518 | Values: 3132.4 3173.0 3218.8 3221.3 3257.6 5170.7 5251.7 5290.9 5310.0 5357.4 5289.9 5329.8 5366.5 5366.6 5371.7 4702.2 4765.0 4819.5 4874.4 4876.0 4718.3 4935.0 4953.0 4977.9 4979.4 4757.3 4783.9 4834.2 4843.7 4867.3 4793.8 4803.4 4806.7 4819.5 4826.8 4669.0 4794.9 4803.4 4810.3 4870.9 5085.9 5099.3 5119.0 5119.9 5128.1 5645.2 5647.7 5648.5 5687.0 5700.8 5583.8 5603.0 5615.9 5626.5 5681.1 5336.3 5359.5 5363.7 5366.3 5367.2 5688.9 5774.0 5831.1 5831.3 5890.3 5638.1 5679.8 5694.4 5696.9 5747.2 5628.2 5651.5 5657.2 5658.9 5661.5 5528.2 5597.5 5608.7 5611.1 5611.5 5615.9 5618.8 5619.4 5627.3 5660.4 4323.8 4324.8 4328.1 4328.5 4371.3 3795.4 3870.5 3895.8 3902.9 3927.1 5275.1 5299.8 5306.2 5319.8 5323.1 5542.5 5681.9 5699.3 5701.8 5711.5 5197.4 5224.9 5297.7 5310.9 5344.5 4805.7 4826.1 4833.6 4846.1 4875.2 5758.1 5879.5 5898.8 5903.6 5910.5 5656.1 5713.8 5733.1 5734.5 5777.4 5901.3 5950.0 5952.0 5956.5 5957.3 5417.6 5498.3 5617.4 5671.9 5683.2 5647.6 5676.7 5685.2 5688.2 5715.3 5512.9 5517.8 5524.8 5529.1 5532.6 5398.1 5489.6 5493.9 5553.7 5637.6 5477.2 5493.5 5500.8 5504.6 5505.4 5573.3 5594.7 5605.2 5612.3 5658.8 5366.8 5402.3 5446.8 5486.3 5501.4 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | [#1] ext.html Cycles:180 Average:45906.52 Median:37910.93 stddev:77568.57 (204.6%) stddev-sans-first:77711.33 05:21:53 INFO - PROCESS | 20518 | Values: 522.8 542.7 550.4 564.3 584.5 27915.2 28368.3 28372.1 28380.6 35670.3 38399.8 38711.6 38883.0 38887.8 38963.2 8485.4 8705.7 8714.7 8716.1 8716.1 8500.2 8592.6 8604.3 8615.5 8627.2 8623.3 8922.4 8944.7 8947.1 8953.0 8802.0 8876.1 8876.2 8877.9 8880.9 8738.6 8914.1 8918.6 8919.7 8924.3 40017.8 40314.2 40356.0 40400.6 40405.0 3305.6 3316.4 3352.3 3375.8 3418.9 29032.6 29157.4 29512.6 30359.0 30534.2 3920.4 3941.5 4030.5 4067.3 4184.2 243538.0 251010.0 252416.0 252673.0 252832.0 42854.0 43368.8 43371.8 55746.0 56659.0 43226.8 43293.8 43402.0 43571.8 43599.0 14169.9 14230.4 14385.6 14412.7 14413.4 12142.3 12370.1 12405.2 12467.4 12468.9 14515.7 14571.3 14740.0 15055.5 15106.6 6095.7 6147.7 6154.6 6157.1 6199.1 908.4 956.8 974.5 1087.8 1095.2 27041.7 27730.3 28050.6 28191.7 28300.7 1087.9 1108.4 1179.4 1220.9 1221.0 15516.7 15804.6 16069.2 16149.4 16164.0 342955.0 352850.0 353012.0 353209.0 353983.8 54720.5 55215.4 55225.2 55292.2 55334.4 1232.9 1357.7 1424.5 1442.4 1461.1 29371.9 32457.0 33255.5 33985.0 34930.7 50452.5 51060.0 51105.7 51117.5 51197.7 275026.0 277270.0 278001.0 280173.0 282163.0 41764.0 42796.1 42945.4 42983.6 43918.6 40743.9 42998.1 43305.6 43956.3 44487.6 36195.8 36639.0 36937.4 37091.1 37823.2 37017.4 37115.3 37564.4 38137.0 38221.6 37872.2 37949.6 37981.6 37992.6 39685.4 29109.9 29552.9 31236.0 31857.2 33788.3 26110.0 26329.7 26406.9 26438.0 26593.9 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | [#2] jquery.html Cycles:180 Average:26147.56 Median:44287.39 stddev:80749.14 (182.3%) stddev-sans-first:80952.46 05:21:53 INFO - PROCESS | 20518 | Values: 366.4 366.5 367.6 371.1 374.7 13633.3 13753.7 16336.6 17250.7 18216.8 14210.8 15039.7 15090.0 15109.5 16050.3 5140.0 5293.0 5308.0 5315.0 5329.0 3976.5 5250.2 5298.7 5614.7 5863.0 5631.6 5787.7 5838.6 5841.4 5841.6 5832.3 5838.3 5839.9 5841.5 5845.7 4972.4 5057.9 5068.2 5098.1 5098.6 20152.5 20259.2 20291.2 20314.2 20428.2 1916.0 2076.9 2353.7 2382.1 2858.3 9170.0 9467.6 9666.1 9681.8 12256.4 1767.0 1806.7 1865.5 1918.3 1926.1 52201.7 57920.0 59351.7 59852.0 60296.7 9777.8 10055.5 10078.4 10087.3 10117.0 13081.7 13244.7 13246.3 13254.2 13254.6 7514.0 7707.0 7711.1 7754.5 7755.6 7522.6 7607.2 7732.7 7740.9 7769.4 4486.6 4490.8 4494.0 4519.2 4527.6 1706.2 1751.8 1771.3 1773.9 1776.1 447.8 926.0 937.7 946.5 948.6 8803.9 10612.0 10860.6 11053.8 11215.8 486.4 501.2 509.6 512.5 517.0 6061.4 6366.7 6393.3 6558.5 6570.4 459316.0 468751.0 505153.0 512792.0 519298.0 65919.0 73183.0 74744.6 75260.0 76348.0 1133.7 1181.8 1182.9 1228.5 1256.7 14750.9 16008.1 16213.4 16375.0 16513.1 30752.2 31363.1 32686.8 33571.7 35211.0 42561.4 43135.0 43639.3 44080.8 44494.0 7177.7 7370.7 7383.8 7453.4 7487.6 8075.0 9595.0 10939.3 11478.7 11683.5 9921.2 10394.6 10581.5 10647.4 10693.4 10449.2 10452.7 10582.8 10612.4 10739.4 10307.1 10492.4 10570.2 10808.3 10887.3 7581.0 7614.4 7616.5 7626.1 7626.7 10395.4 10648.3 10718.1 10804.9 10961.4 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | [#3] mootools.html Cycles:180 Average:5676.64 Median:2848.98 stddev:2982.11 (104.7%) stddev-sans-first:2971.94 05:21:53 INFO - PROCESS | 20518 | Values: 1254.3 1261.6 1292.2 1303.1 1393.6 7018.9 7905.8 8015.7 8023.2 8028.6 7877.1 8056.8 8059.3 8061.7 8067.0 2055.2 2101.4 2327.1 2373.2 2392.6 2376.0 2384.0 2384.1 2386.7 2387.3 2318.5 2384.2 2385.8 2385.9 2389.0 2034.5 2312.6 2364.3 2390.8 2397.6 2341.2 2356.4 2380.2 2387.6 2390.3 7697.1 7723.2 7741.5 7758.7 7778.5 4909.5 5004.8 5035.2 5041.5 5042.3 3291.2 3323.8 3384.6 3452.3 3465.6 1164.7 1174.2 1180.7 1189.6 1242.4 11381.3 11398.2 11437.4 11440.8 11451.3 4574.9 4595.1 4651.8 4663.5 4666.3 9799.6 9800.2 9802.9 9816.4 9823.4 5146.2 5151.8 5169.1 5169.9 5171.4 4649.0 4697.0 4703.5 4705.2 4706.1 3809.1 3891.2 3895.1 3902.7 3930.4 1222.3 1223.7 1229.1 1233.3 1239.8 1304.6 1304.8 1307.9 1311.8 1348.5 7678.5 7680.4 7848.6 7855.0 7857.8 506.4 516.7 517.7 517.7 526.5 5767.7 5775.7 5789.7 5821.5 5824.6 9296.8 9955.4 10128.1 10133.2 10168.6 9894.1 10000.7 10006.9 10020.2 10029.6 7522.3 7581.1 7634.4 7675.6 7687.2 6979.4 7430.1 7432.0 7435.4 7438.9 8556.9 8568.7 8617.4 8633.5 8731.4 8793.9 9006.7 9013.0 9029.1 9126.9 7097.5 7229.9 7232.2 7234.3 7237.3 7431.1 7487.9 7551.2 7721.1 7726.9 6413.7 7224.9 7259.4 7291.7 7370.5 6570.0 7054.8 7119.6 7138.6 7274.5 7165.9 7222.5 7232.4 7233.0 7240.2 6622.4 6646.6 6651.7 6660.4 6670.1 6603.1 6643.1 6645.6 6769.6 6775.7 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | [#4] prototype.html Cycles:180 Average:5228.81 Median:5836.89 stddev:1545.14 (26.5%) stddev-sans-first:1505.29 05:21:53 INFO - PROCESS | 20518 | Values: 341.0 349.2 350.4 353.5 357.4 5836.6 5837.2 5887.9 5887.9 5907.7 5800.4 5810.6 5814.9 5825.8 5835.1 4465.6 4542.9 4560.7 4569.8 4571.4 4557.0 4562.3 4568.6 4575.1 4577.8 4528.1 4536.0 4537.0 4539.3 4539.3 4295.7 4368.5 4408.3 4495.2 4518.0 3945.5 3957.6 3969.3 3988.1 3997.2 5318.1 5512.3 5540.3 5544.4 5570.4 5086.7 5224.7 5225.8 5231.1 5239.3 6148.6 6174.0 6174.7 6182.5 6187.8 4461.2 4462.9 4463.6 4466.8 4467.9 6275.0 6388.6 6423.2 6431.0 6469.2 4572.1 4573.8 4575.8 4576.3 4582.7 4607.7 4616.1 4621.4 4621.5 4629.2 5261.9 5271.2 5272.1 5272.9 5285.6 6075.8 6210.6 6218.3 6219.3 6226.3 1608.4 1632.4 1632.7 1634.9 1635.6 1106.4 1113.1 1115.2 1119.0 1141.7 5784.2 5794.3 5797.4 5803.6 5884.1 6391.3 6391.9 6392.8 6405.2 6407.3 5782.6 5899.0 5914.0 5915.0 5915.8 3404.9 3446.6 3455.2 3458.1 3458.4 6580.8 6607.4 6616.4 6622.4 6630.5 6240.5 6392.4 6489.4 6491.5 6569.5 6703.2 6707.0 6708.1 6718.2 6722.2 6408.9 6428.7 6436.5 6438.6 6439.7 6219.6 6244.2 6344.4 6358.1 6376.7 6707.5 6708.2 6711.4 6712.8 6716.9 4604.4 4606.9 4609.9 4610.4 4613.6 6256.9 6473.6 6473.7 6488.9 6496.8 6298.7 6302.2 6302.9 6306.5 6308.0 6229.3 6249.7 6284.9 6290.9 6292.2 6060.6 6188.7 6190.1 6192.0 6196.0 6314.5 6316.2 6316.7 6324.0 6326.7 6138.6 6170.0 6171.0 6175.7 6182.2 05:21:53 INFO - PROCESS | 20518 | 05:21:53 INFO - PROCESS | 20518 | [#5] yui.html Cycles:180 Average:13053.05 Median:23544.15 stddev:14640.82 (62.2%) stddev-sans-first:14652.61 05:21:53 INFO - PROCESS | 20518 | Values: 721.5 773.8 794.7 798.2 810.5 13447.9 13683.6 13713.3 13728.4 13748.7 12386.1 12731.6 12752.5 12766.2 12772.6 675.1 685.0 818.4 833.6 834.1 822.6 827.5 827.5 827.8 829.3 710.2 834.7 875.4 876.7 876.8 838.0 838.4 839.2 839.7 852.0 617.5 619.4 619.8 623.0 623.7 12948.5 12950.5 13006.5 13023.7 13054.0 12344.4 12759.9 12975.9 13108.7 13210.7 10512.2 10522.8 10528.1 10558.8 10684.5 3595.4 3645.8 3647.4 3647.5 3660.1 48130.3 48198.0 48248.5 48258.3 48284.0 9331.0 9646.8 10195.5 10478.5 10699.0 18189.3 18233.7 18238.6 18244.5 18265.5 7738.7 7749.9 7816.9 7878.7 7880.5 4122.4 4131.8 4168.2 4244.2 4286.9 3207.3 3207.9 3213.7 3230.6 3244.2 550.3 569.2 577.7 585.4 589.6 523.5 659.6 684.6 687.9 696.7 8770.3 9021.2 9227.8 9774.7 9882.6 560.0 703.8 719.0 723.0 763.9 3925.5 4008.5 4111.3 4210.1 4297.2 50334.5 51303.7 51571.0 51648.0 51827.0 46746.0 46944.0 47147.8 47462.8 47715.8 42291.0 42470.2 42659.4 42699.8 42801.4 8421.9 8455.8 8569.7 8636.0 8643.9 32088.5 32295.0 32474.0 32630.0 32739.7 36891.4 37240.8 37515.8 41539.8 41619.2 10045.3 10047.1 10189.3 10511.3 10606.9 10876.8 11012.1 11014.6 11190.6 11256.8 10136.3 10262.1 10440.3 10675.1 10814.9 10149.9 10187.9 10311.0 10486.5 10696.9 10308.4 10410.6 10450.4 10561.3 10697.7 8560.9 8584.4 8968.9 9135.9 9238.2 8913.8 8958.0 8959.2 9041.5 9397.4 05:21:53 INFO - PROCESS | 20518 | -------- Summary: end -------- 05:21:53 INFO - PROCESS | 20518 | 05:21:54 INFO - TEST-INFO | 20518: exit 0 05:21:54 INFO - TEST-OK | dromaeo_css | took 1113537ms 05:21:54 INFO - TEST-START | kraken 05:21:54 INFO - operating with platform_type : linux_ 05:21:54 INFO - Initialising browser for kraken test... 05:21:54 INFO - TEST-INFO | started process 20708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV6tNrk/profile http://localhost:33530/getInfo.html) 05:21:58 INFO - PROCESS | 20708 | __metrics Screen width/height:1600/1200 05:21:58 INFO - PROCESS | 20708 | colorDepth:24 05:21:58 INFO - PROCESS | 20708 | Browser inner width/height: 1024/697 05:21:58 INFO - PROCESS | 20708 | __metrics 05:21:58 INFO - PROCESS | 20708 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:59 INFO - TEST-INFO | 20708: exit 0 05:21:59 INFO - Browser initialized. 05:21:59 INFO - Running cycle 1/1 for kraken test... 05:21:59 INFO - TEST-INFO | started process 20789 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV6tNrk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:11 INFO - PROCESS | 20789 | RSS: Main: 152260608 05:22:11 INFO - PROCESS | 20789 | 05:22:14 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:14 INFO - PROCESS | 20789 | RSS: Main: 192528384 05:22:14 INFO - PROCESS | 20789 | 05:22:17 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-dft) 05:22:17 INFO - PROCESS | 20789 | RSS: Main: 184066048 05:22:17 INFO - PROCESS | 20789 | 05:22:20 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-fft) 05:22:21 INFO - PROCESS | 20789 | RSS: Main: 167596032 05:22:21 INFO - PROCESS | 20789 | 05:22:23 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33530/tests/kraken/driver.html?testName=audio-oscillator) 05:22:24 INFO - PROCESS | 20789 | RSS: Main: 169656320 05:22:24 INFO - PROCESS | 20789 | 05:22:26 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:26 INFO - PROCESS | 20789 | RSS: Main: 170524672 05:22:26 INFO - PROCESS | 20789 | 05:22:29 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33530/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:30 INFO - PROCESS | 20789 | RSS: Main: 170209280 05:22:30 INFO - PROCESS | 20789 | 05:22:33 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33530/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:34 INFO - PROCESS | 20789 | RSS: Main: 172584960 05:22:34 INFO - PROCESS | 20789 | 05:22:37 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33530/tests/kraken/driver.html?testName=json-parse-financial) 05:22:37 INFO - PROCESS | 20789 | RSS: Main: 171053056 05:22:37 INFO - PROCESS | 20789 | 05:22:39 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:39 INFO - PROCESS | 20789 | RSS: Main: 183054336 05:22:39 INFO - PROCESS | 20789 | 05:22:41 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:42 INFO - PROCESS | 20789 | RSS: Main: 182792192 05:22:42 INFO - PROCESS | 20789 | 05:22:44 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:44 INFO - PROCESS | 20789 | RSS: Main: 193417216 05:22:44 INFO - PROCESS | 20789 | 05:22:47 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:47 INFO - PROCESS | 20789 | RSS: Main: 197967872 05:22:47 INFO - PROCESS | 20789 | 05:22:50 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:50 INFO - PROCESS | 20789 | RSS: Main: 197341184 05:22:50 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | Cycle 1(1): loaded http://localhost:33530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33530/tests/kraken/driver.html?testName=ai-astar) 05:22:52 INFO - PROCESS | 20789 | RSS: Main: 258084864 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | __start_tp_report 05:22:52 INFO - PROCESS | 20789 | _x_x_mozilla_page_load 05:22:52 INFO - PROCESS | 20789 | _x_x_mozilla_page_load_details 05:22:52 INFO - PROCESS | 20789 | |i|pagename|runs| 05:22:52 INFO - PROCESS | 20789 | |0;ai-astar;111;111;105;109;110;110;102;111;110;111 05:22:52 INFO - PROCESS | 20789 | |1;audio-beat-detection;152;125;153;164;134;153;150;127;161;127 05:22:52 INFO - PROCESS | 20789 | |2;audio-dft;160;161;160;162;160;161;160;166;160;160 05:22:52 INFO - PROCESS | 20789 | |3;audio-fft;73;73;135;95;73;74;72;118;95;72 05:22:52 INFO - PROCESS | 20789 | |4;audio-oscillator;96;96;139;95;96;95;148;96;96;137 05:22:52 INFO - PROCESS | 20789 | |5;imaging-gaussian-blur;118;115;115;115;115;115;115;115;115;115 05:22:52 INFO - PROCESS | 20789 | |6;imaging-darkroom;146;145;145;145;145;145;145;145;145;146 05:22:52 INFO - PROCESS | 20789 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;97;96 05:22:52 INFO - PROCESS | 20789 | |8;json-parse-financial;55;55;56;55;55;56;56;66;54;54 05:22:52 INFO - PROCESS | 20789 | |9;json-stringify-tinderbox;66;66;65;66;67;66;66;66;66;66 05:22:52 INFO - PROCESS | 20789 | |10;stanford-crypto-aes;84;90;83;82;84;84;84;84;86;84 05:22:52 INFO - PROCESS | 20789 | |11;stanford-crypto-ccm;121;120;121;115;114;114;120;127;117;116 05:22:52 INFO - PROCESS | 20789 | |12;stanford-crypto-pbkdf2;152;139;148;151;141;143;150;144;150;150 05:22:52 INFO - PROCESS | 20789 | |13;stanford-crypto-sha256-iterative;68;69;71;68;68;68;68;70;69;66 05:22:52 INFO - PROCESS | 20789 | __end_tp_report 05:22:52 INFO - PROCESS | 20789 | __start_cc_report 05:22:52 INFO - PROCESS | 20789 | _x_x_mozilla_cycle_collect,962 05:22:52 INFO - PROCESS | 20789 | __end_cc_report 05:22:52 INFO - PROCESS | 20789 | __startTimestamp1455196972912__endTimestamp 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | ------- Summary: start ------- 05:22:52 INFO - PROCESS | 20789 | Number of tests: 14 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.06 (2.8%) stddev-sans-first:3.15 05:22:52 INFO - PROCESS | 20789 | Values: 111.0 111.0 105.0 109.0 110.0 110.0 102.0 111.0 110.0 111.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:152.50 stddev:14.86 (9.7%) stddev-sans-first:15.51 05:22:52 INFO - PROCESS | 20789 | Values: 152.0 125.0 153.0 164.0 134.0 153.0 150.0 127.0 161.0 127.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#2] audio-dft Cycles:10 Average:161.00 Median:160.50 stddev:1.89 (1.2%) stddev-sans-first:1.96 05:22:52 INFO - PROCESS | 20789 | Values: 160.0 161.0 160.0 162.0 160.0 161.0 160.0 166.0 160.0 160.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#3] audio-fft Cycles:10 Average:88.00 Median:73.00 stddev:22.58 (30.9%) stddev-sans-first:23.29 05:22:52 INFO - PROCESS | 20789 | Values: 73.0 73.0 135.0 95.0 73.0 74.0 72.0 118.0 95.0 72.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:22.21 (23.1%) stddev-sans-first:23.02 05:22:52 INFO - PROCESS | 20789 | Values: 96.0 96.0 139.0 95.0 96.0 95.0 148.0 96.0 96.0 137.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:0.00 05:22:52 INFO - PROCESS | 20789 | Values: 118.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 05:22:52 INFO - PROCESS | 20789 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:22:52 INFO - PROCESS | 20789 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 97.0 96.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:3.52 (6.3%) stddev-sans-first:3.71 05:22:52 INFO - PROCESS | 20789 | Values: 55.0 55.0 56.0 55.0 55.0 56.0 56.0 66.0 54.0 54.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 05:22:52 INFO - PROCESS | 20789 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.17 (2.6%) stddev-sans-first:2.30 05:22:52 INFO - PROCESS | 20789 | Values: 84.0 90.0 83.0 82.0 84.0 84.0 84.0 84.0 86.0 84.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:120.00 stddev:4.09 (3.4%) stddev-sans-first:4.24 05:22:52 INFO - PROCESS | 20789 | Values: 121.0 120.0 121.0 115.0 114.0 114.0 120.0 127.0 117.0 116.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:4.64 (3.1%) stddev-sans-first:4.52 05:22:52 INFO - PROCESS | 20789 | Values: 152.0 139.0 148.0 151.0 141.0 143.0 150.0 144.0 150.0 150.0 05:22:52 INFO - PROCESS | 20789 | 05:22:52 INFO - PROCESS | 20789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 05:22:52 INFO - PROCESS | 20789 | Values: 68.0 69.0 71.0 68.0 68.0 68.0 68.0 70.0 69.0 66.0 05:22:52 INFO - PROCESS | 20789 | -------- Summary: end -------- 05:22:52 INFO - PROCESS | 20789 | 05:22:53 INFO - TEST-INFO | 20789: exit 0 05:22:53 INFO - TEST-OK | kraken | took 59385ms 05:22:53 INFO - SUITE-END | took 1172s 05:22:54 INFO - Completed test suite (00:19:33) 05:22:54 INFO - Working with test: dromaeo_css 05:22:54 INFO - Generating results file: dromaeo_css 05:22:54 INFO - Working with test: kraken 05:22:54 INFO - Generating results file: kraken 05:22:54 INFO - javascript benchmark 05:22:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:22:54 INFO - process_Request line: dromaeo_css 6826.97 graph.html#tests=[[72,64,35]] 05:22:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:22:54 INFO - process_Request line: kraken 1508.90 graph.html#tests=[[232,64,35]] 05:22:54 INFO - RETURN: dromaeo_css: 6826.97 05:22:54 INFO - RETURN: kraken: 1508.90 05:22:54 INFO - javascript benchmark 05:22:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3132.373525294941, 3173.032225171322, 3218.8229647369385, 3221.3235220603674, 3257.5928008998876, 5170.715610641413, 5251.684898906064, 5290.894182116355, 5309.973450132748, 5357.357117145938, 5289.894202115965, 5329.840104796853, 5366.543843773275, 5366.570674346052, 5371.704556249405, 4702.153612349775, 4765.046990601885, 4819.5180481951875, 4874.415070191582, 4876.049170411771, 4718.268668356411, 4934.950650493503, 4952.975235123819, 4977.875553111183, 4979.427365852937, 4757.26262429324, 4783.880402989918, 4834.226523756182, 4843.709377437365, 4867.269909513566, 4793.784279707422, 4803.3995750531185, 4806.663533552618, 4819.542143496362, 4826.7827947742435, 4668.976655116737, 4794.880127996793, 4803.3995750531185, 4810.302506136625, 4870.902581948341, 5085.898282034339, 5099.286099946011, 5118.974405127988, 5119.872003199913, 5128.076946149691, 5645.2096706461125, 5647.689377084259, 5648.519875810561, 5686.9715651421475, 5700.7719691212305, 5583.832485025456, 5603.019471592495, 5615.943840561583, 5626.521745651625, 5681.062624666966, 5336.332958380202, 5359.464053594648, 5363.731813409314, 5366.329208848933, 5367.1680889462195, 5688.8862222755315, 5774.04728219839, 5831.067029275296, 5831.271091113611, 5890.322612899571, 5638.069718496402, 5679.829605111853, 5694.402087780723, 5696.8860622787315, 5747.224124743189, 5628.212050312959, 5651.519620832193, 5657.20799088128, 5658.943410565842, 5661.518770904519, 5528.198411230349, 5597.468240517144, 5608.747606357723, 5611.130274807411, 5611.494965453047, 5615.943840561624, 5618.775248989995, 5619.353774315924, 5627.268455100811, 5660.433956604306, 4323.848665296699, 4324.805383757738, 4328.069465065026, 4328.523862375137, 4371.30059190528, 3795.35478968576, 3870.4581358609817, 3895.8441662333757, 3902.8829135125993, 3927.096767743435, 5275.050490911673, 5299.788008479618, 5306.163021868787, 5319.760610772524, 5323.148296272655, 5542.473465020817, 5681.857953551194, 5699.316082070095, 5701.771929122871, 5711.485966263056, 5197.350331208599, 5224.895502089937, 5297.735113244323, 5310.92033619496, 5344.545713614309, 4805.687630304019, 4826.107170173529, 4833.637477189154, 4846.103470857903, 4875.171220892456, 5758.107493338539, 5879.5002424794375, 5898.793542226002, 5903.616264942765, 5910.527157827363, 5656.095024796013, 5713.800016999551, 5733.111367738007, 5734.541236701138, 5777.364489906191, 5901.3213480448585, 5950.0, 5952.0476723724, 5956.493698035542, 5957.344692083954, 5417.566594672496, 5498.257735205696, 5617.354004289559, 5671.8865622688145, 5683.204351390891, 5647.604667673223, 5676.7161641918565, 5685.204071430086, 5688.232088668143, 5715.257016587817, 5512.924979628934, 5517.834464966058, 5524.8342549723575, 5529.115341545334, 5532.585056120726, 5398.055340315507, 5489.64317319373, 5493.862653433696, 5553.72231388437, 5637.577181711306, 5477.178423236546, 5493.533049690821, 5500.779968801203, 5504.6421982571, 5505.394406615189, 5573.331200255995, 5594.748236329457, 5605.243292155506, 5612.298462692163, 5658.801941932177, 5366.838994830161, 5402.297701298806, 5446.782128714807, 5486.286782718221, 5501.3948465667945], "unit": "score", "name": "dojo.html", "value": 5227.533046623496}, {"lowerIsBetter": false, "replicates": [522.7778194267438, 542.6689719271245, 550.4440515079768, 564.2580007290413, 584.4856526256893, 27915.162545123654, 28368.290792730193, 28372.148835534914, 28380.574291385645, 35670.2865942681, 38399.77602463734, 38711.61288387115, 38883.0, 38887.805560972156, 38963.24665390064, 8485.406021578476, 8705.651773929067, 8714.738557843275, 8716.08481109484, 8716.128387161265, 8500.234978851902, 8592.570371481432, 8604.26863716585, 8615.483071015728, 8627.180417860325, 8623.267022303111, 8922.420042697237, 8944.686935957243, 8947.105289471034, 8953.0, 8802.03177650458, 8876.112388761072, 8876.156765107304, 8877.866831997526, 8880.8667869982, 8738.563071846382, 8914.108589141098, 8918.55407229636, 8919.73240802777, 8924.286057115416, 40017.79991100055, 40314.19371612581, 40356.0, 40400.59599403998, 40405.0, 3305.5537502437105, 3316.436205845012, 3352.2960178362573, 3375.831208439593, 3418.8632454701783, 29032.564511532342, 29157.41685166285, 29512.557311640343, 30359.0, 30534.236644083852, 3920.3923391874305, 3941.5467221269632, 4030.5364883038533, 4067.28822456069, 4184.246835569596, 243538.0, 251010.0, 252416.0, 252673.0, 252832.0, 42854.0, 43368.78315608402, 43371.783141084095, 55746.0, 56659.0, 43226.783866081096, 43293.78353108277, 43402.0, 43571.78214108909, 43599.0, 14169.85830141706, 14230.43465218825, 14385.64035899111, 14412.711745765026, 14413.42346306157, 12142.271463712206, 12370.072244581692, 12405.193662411913, 12467.438965246585, 12468.875311246953, 14515.693587576958, 14571.344289506998, 14740.0, 15055.54833355001, 15106.622334441507, 6095.664738439428, 6147.692615369214, 6154.569180157436, 6157.107219453154, 6199.101130336076, 908.3823000359687, 956.8134213828237, 974.5370948799264, 1087.7933192693363, 1095.2169199022737, 27041.729582704316, 27730.3067423312, 28050.579241311396, 28191.71808281891, 28300.71699283022, 1087.9347239165675, 1108.41808050774, 1179.4279774309452, 1220.9145359824904, 1220.9987809995896, 15516.689666206612, 15804.604884877741, 16069.196540173178, 16149.354025838835, 16164.0, 342955.0, 352850.0, 353012.0, 353209.0, 353983.84064637125, 54720.45279547233, 55215.447845521834, 55225.171622425696, 55292.170617440774, 55334.446655533735, 1232.9013678905667, 1357.735241627893, 1424.4587056918306, 1442.4158215922569, 1461.0941216445658, 29371.853140734158, 32457.0, 33255.50116748202, 33985.0, 34930.65069349376, 50452.49547504625, 51060.0, 51105.74447127741, 51117.48882511276, 51197.744011279705, 275026.0, 277270.0, 278001.0, 280173.0, 282163.0, 41764.0, 42796.144077117664, 42945.3558196621, 42983.570164297955, 43918.560814392724, 40743.91761573601, 42998.14003719971, 43305.56694433141, 43956.34065489084, 44487.55512444834, 36195.819020904724, 36639.0, 36937.44593831148, 37091.07272318214, 37823.243535129695, 37017.444738328406, 37115.25769484649, 37564.43653345147, 38137.0, 38221.61778382181, 37872.242555148194, 37949.62050379571, 37981.620183798914, 37992.620073798906, 39685.404718928665, 29109.85445072761, 29552.852235739545, 31236.0, 31857.20356991001, 33788.32423351568, 26110.0, 26329.73670263273, 26406.867965660047, 26438.0, 26593.867030664722], "unit": "score", "name": "ext.html", "value": 18219.171065043894}, {"lowerIsBetter": false, "replicates": [366.43751840924176, 366.49423795162687, 367.5607648859613, 371.0741699459848, 374.7133442916168, 13633.250171240577, 13753.724925501483, 16336.591585210375, 17250.741238881412, 18216.817831821696, 14210.786838197435, 15039.699206015874, 15090.0, 15109.471168509104, 16050.27773750181, 5139.974300128494, 5293.04725149473, 5308.044551980642, 5314.973425132869, 5328.973355133219, 3976.542697589771, 5250.159974404077, 5298.6555873868265, 5614.691191984439, 5862.970685146568, 5631.60578759487, 5787.710614469281, 5838.591298609099, 5841.386654401291, 5841.561882858781, 5832.329282132567, 5838.299404071496, 5839.941600583982, 5841.503472204868, 5845.678487683176, 4972.403311602631, 5057.873553161164, 5068.239764035387, 5098.082345177866, 5098.643094983353, 20152.49618759528, 20259.189632414687, 20291.188352465884, 20314.18743250283, 20428.182872685076, 1915.990420047891, 2076.885771282594, 2353.658719485682, 2382.106709983756, 2858.2568532181576, 9170.0, 9467.573959171854, 9666.130048295618, 9681.806363872754, 12256.387180640932, 1766.9823301766946, 1806.7289906513997, 1865.5056410051347, 1918.3094086128983, 1926.1428664244418, 52201.73899130518, 57920.0, 59351.70324148352, 59852.0, 60296.69851650714, 9777.755556111011, 10055.547500362502, 10078.445685487222, 10087.344322619154, 10117.0, 13081.738365232643, 13244.73510529784, 13246.337683115806, 13254.204747715168, 13254.602361929157, 7513.962430187814, 7707.0, 7711.0746710395115, 7754.526639938506, 7755.612219389008, 7522.623868806538, 7607.16321204667, 7732.6520306586335, 7740.922590774133, 7769.417293702995, 4486.59620634138, 4490.820367185276, 4493.955060449419, 4519.209138400766, 4527.615152712056, 1706.1725063344268, 1751.7547543343687, 1771.3268957796213, 1773.9379121730935, 1776.111944027986, 447.78953891670864, 925.9722208333761, 937.6905621145006, 946.536197263336, 948.6252930092575, 8803.911960880438, 10612.0, 10860.565577376974, 11053.778924421467, 11215.831762523569, 486.3822944860008, 501.22560643805406, 509.630517874538, 512.4619149892598, 517.0331480132102, 6061.363556826558, 6366.745330186741, 6393.326622748885, 6558.540902136805, 6570.408663220333, 459316.0, 468751.0, 505153.0, 512792.0, 519298.0, 65919.0, 73183.0, 74744.62627686826, 75260.0, 76348.0, 1133.6769020829024, 1181.8345431639577, 1182.8817118288102, 1228.4778968938165, 1256.7109564799964, 14750.926245368704, 16008.119553424207, 16213.351465941701, 16375.017498949624, 16513.091779952218, 30752.231194220323, 31363.05910822679, 32686.83656581702, 33571.66428335783, 35211.0, 42561.361579575714, 43135.0, 43639.345409819514, 44080.77959610181, 44494.0, 7177.712891484282, 7370.705171793283, 7383.778486645409, 7453.40372770188, 7487.625618718933, 8074.959625201836, 9595.0, 10939.277570506712, 11478.655640330804, 11683.532658693557, 9921.156701680438, 10394.636187733393, 10581.523831427758, 10647.361158330525, 10693.411862347646, 10449.216308777024, 10452.68641940743, 10582.8412573813, 10612.416317102634, 10739.409332486475, 10307.123894468754, 10492.422916739653, 10570.154387648816, 10808.297460665031, 10887.292325998786, 7581.0, 7614.390848731978, 7616.466847320635, 7626.122995855548, 7626.694932202649, 10395.428251445941, 10648.254622176373, 10718.088962437969, 10804.891951080388, 10961.397123157984], "unit": "score", "name": "jquery.html", "value": 7957.5545691992675}, {"lowerIsBetter": false, "replicates": [1254.3101294288142, 1261.5836773864619, 1292.160095937641, 1303.0617955072348, 1393.574959637311, 7018.929810701898, 7905.84188316234, 8015.679372825095, 8023.157568455315, 8028.638711257993, 7877.133515313311, 8056.8388632227325, 8059.314958228543, 8061.717839875606, 8067.0, 2055.177928828473, 2101.4011006863047, 2327.057541695616, 2373.181252467896, 2392.569337519246, 2375.9762402375927, 2383.988080059606, 2384.082128380577, 2386.653935179398, 2387.343480542856, 2318.547883162784, 2384.248961577098, 2385.7733515316017, 2385.8926348314367, 2388.9880550597222, 2034.5117171878717, 2312.5952958232324, 2364.3025307534317, 2390.8206884483734, 2397.6043952747777, 2341.1571834139695, 2356.36378177891, 2380.238323736405, 2387.6179811230295, 2390.306811024801, 7697.076350837935, 7723.227677232288, 7741.496802707806, 7758.6896524138965, 7778.455508114434, 4909.509049095098, 5004.849854504334, 5035.169197082477, 5041.521055499722, 5042.268871013719, 3291.1772056985756, 3323.833808309575, 3384.5938487381427, 3452.2922800825772, 3465.636108208627, 1164.714644912002, 1174.183942160199, 1180.728432460539, 1189.6371606659966, 1242.4471110355896, 11381.260218085881, 11398.202125851194, 11437.370944598044, 11440.771184576344, 11451.31292122467, 4574.885627859264, 4595.1269258841385, 4651.837185698484, 4663.51033141522, 4666.346711460398, 9799.608015679436, 9800.215982721365, 9802.852957205647, 9816.411015339103, 9823.361481503822, 5146.202338637517, 5151.793928242903, 5169.121249387613, 5169.870753231199, 5171.4052883918075, 4649.0, 4696.953030469652, 4703.529647035269, 4705.176594096088, 4706.058788242297, 3809.0858194033785, 3891.1828516011956, 3895.0651843557343, 3902.707296952683, 3930.3514920037874, 1222.2971791220084, 1223.718544734716, 1229.1150371732338, 1233.2600439736086, 1239.7892358299111, 1304.6281809684385, 1304.7977563477486, 1307.9346032698327, 1311.8097875807955, 1348.5347555093476, 7678.462507624525, 7680.385569154454, 7848.56832874186, 7855.0, 7857.764267071997, 506.4252073896081, 516.6925679220858, 517.6867994863129, 517.7049082023286, 526.5471694342939, 5767.711614419262, 5775.740091695884, 5789.726260222744, 5821.476067153892, 5824.5631577631, 9296.814063718688, 9955.402675839472, 10128.088472037405, 10133.189344852393, 10168.593256269667, 9894.06643257939, 10000.749831288047, 10006.949965250127, 10020.198384129251, 10029.648962286285, 7522.285382888617, 7581.090269167735, 7634.351080158138, 7675.61621918913, 7687.192844751333, 6979.371856532734, 7430.071241094864, 7432.0, 7435.367993720594, 7438.851222975619, 8556.871646925176, 8568.657253709782, 8617.439866408664, 8633.481991080555, 8731.432456890281, 8793.868091978498, 9006.729798106067, 9013.0, 9029.142231487998, 9126.908730912872, 7097.538659987084, 7229.927700722926, 7232.168300645493, 7234.276572342724, 7237.3486386225495, 7431.108267007994, 7487.887681684888, 7551.207123252199, 7721.073471183494, 7726.884096738666, 6413.679316034273, 7224.89162662571, 7259.382952449101, 7291.744788932362, 7370.520916140434, 6570.047343135314, 7054.823629409306, 7119.608421536658, 7138.607376594129, 7274.527155734861, 7165.8925116122255, 7222.494425390172, 7232.385247253832, 7232.963835180791, 7240.203577606354, 6622.403983641495, 6646.634435105922, 6651.73393064272, 6660.367265109807, 6670.066190733204, 6603.075569420189, 6643.1031810704935, 6645.634490103091, 6769.559978601375, 6775.661216939035], "unit": "score", "name": "mootools.html", "value": 4579.488675112195}, {"lowerIsBetter": false, "replicates": [340.96590340965906, 349.2107836289984, 350.4095598915826, 353.4962678183588, 357.41919381005863, 5836.5914385993, 5837.182794408781, 5887.8822423551555, 5887.911681324773, 5907.704614769265, 5800.4489573490555, 5810.622309549876, 5814.854628634275, 5825.796097136601, 5835.124731290298, 4465.598096171344, 4542.886427839314, 4560.703554268978, 4569.771511424432, 4571.428571428572, 4557.02024064826, 4562.338460923181, 4568.634509239253, 4575.130725162225, 4577.793999270024, 4528.071745292207, 4536.047430039679, 4537.024539723959, 4539.251023581121, 4539.319102134673, 4295.699301048928, 4368.49762277339, 4408.250597398418, 4495.168393847116, 4518.0, 3945.5462621798574, 3957.564667886559, 3969.3053715599945, 3988.12261302513, 3997.1805779815068, 5318.1225097858805, 5512.283403157564, 5540.279763630702, 5544.417836127189, 5570.442955704397, 5086.669366491166, 5224.738763061831, 5225.790968361299, 5231.110711179109, 5239.345081864767, 6148.569600127993, 6173.969130154321, 6174.660393678346, 6182.536309776785, 6187.783427580058, 4461.21928662486, 4462.933056004163, 4463.620592249663, 4466.82132714691, 4467.888302792424, 6274.964630835907, 6388.552801303864, 6423.197100362455, 6430.967845160744, 6469.159009328804, 4572.08558288337, 4573.794179261941, 4575.816967321336, 4576.290674945389, 4582.679212455163, 4607.654425918069, 4616.146012987608, 4621.376114224604, 4621.537846215351, 4629.166749985035, 5261.921071183935, 5271.182966640177, 5272.103742363807, 5272.894542109137, 5285.55072818807, 6075.817725468155, 6210.5652604317265, 6218.2538095427935, 6219.253689557192, 6226.283977342573, 1608.404890190637, 1632.3552196882165, 1632.6653036127566, 1634.8855580109278, 1635.607454210981, 1106.4246591772394, 1113.1095123900848, 1115.1524841120645, 1118.981726628764, 1141.6917432293235, 5784.161296611967, 5794.275715535558, 5797.391273916262, 5803.622764520293, 5884.08796636522, 6391.328910464427, 6391.872162556816, 6392.808215753442, 6405.167328247298, 6407.263164736115, 5782.595218334676, 5899.0, 5914.0, 5914.9704251479325, 5915.7633694652595, 3404.880829170967, 3446.5691788526433, 3455.1707590178175, 3458.1181798641187, 3458.4466485362723, 6580.8354791130605, 6607.405333520006, 6616.371444712745, 6622.4039836413995, 6630.474990752154, 6240.5319601030105, 6392.360763923663, 6489.448396886223, 6491.480681545465, 6569.540132190701, 6703.195616525853, 6707.0, 6708.060871477997, 6718.160229971254, 6722.218612067903, 6408.935910640834, 6428.742850285937, 6436.485081193587, 6438.581492202992, 6439.7424103035355, 6219.595726277777, 6244.220136552399, 6344.365563443619, 6358.109864619049, 6376.74493020274, 6707.463402927657, 6708.161479815023, 6711.395974362331, 6712.83217919556, 6716.865662686621, 4604.355390245435, 4606.907861842677, 4609.930851037304, 4610.446746390455, 4613.5847773700525, 6256.906146407717, 6473.611583305017, 6473.676316184078, 6488.902666459912, 6496.7726129585235, 6298.748050077946, 6302.180716506825, 6302.905456418066, 6306.527010474141, 6308.0, 6229.345918678474, 6249.718762655601, 6284.905726414016, 6290.874182516232, 6292.182016337847, 6060.606060606046, 6188.721507532082, 6190.102435146969, 6192.0, 6195.96902015487, 6314.4632706218645, 6316.242050953915, 6316.684165791784, 6324.0, 6326.652034137983, 6138.600990935575, 6170.012797952306, 6171.0, 6175.722092505758, 6182.196314479089], "unit": "score", "name": "prototype.html", "value": 4736.6685298756365}, {"lowerIsBetter": false, "replicates": [721.4661150748444, 773.8181527341075, 794.7059587952458, 798.173890023825, 810.4893916832394, 13447.865521344784, 13683.589492315234, 13713.31433428327, 13728.382222799974, 13748.725025499496, 12386.07104467164, 12731.554395596157, 12752.489900403973, 12766.170198937085, 12772.616821495347, 675.0684056002709, 684.9760258390958, 818.4271010292819, 833.5998720614109, 834.1491678487939, 822.5681517203457, 827.4538804389105, 827.4745536584282, 827.8302947895667, 829.2992421403934, 710.1726488640727, 834.6911642692182, 875.3916028360292, 876.6843936182969, 876.8027193881389, 838.0404436919754, 838.4005436113177, 839.215333663027, 839.7061028639988, 851.9787005324855, 617.4658920034183, 619.4239357397619, 619.8264485943943, 622.9501639868799, 623.688155922039, 12948.482060717653, 12950.54673086447, 13006.479740810357, 13023.739525209538, 13054.0, 12344.38278086092, 12759.872401275961, 12975.87024129756, 13108.672283192996, 13210.66973325665, 10512.211584131144, 10522.84215736757, 10528.105111065568, 10558.78882422355, 10684.51919663617, 3595.442706380489, 3645.76302540334, 3647.434647629622, 3647.544056992876, 3660.084978755311, 48130.27804582934, 48198.0, 48248.51751482475, 48258.27612585814, 48283.99999999965, 9330.95334523323, 9646.758831029281, 10195.452495080252, 10478.476076196159, 10699.037086662238, 18189.27242910295, 18233.7264941026, 18238.63522729538, 18244.543886402946, 18265.45203643893, 7738.651760670783, 7749.92250077492, 7816.921830781619, 7878.684852605831, 7880.487768295043, 4122.443470131494, 4131.793410329472, 4168.228877657643, 4244.236037513216, 4286.935695964563, 3207.342494788609, 3207.9037628870706, 3213.7268332191557, 3230.644629090798, 3244.221386867182, 550.2708910693267, 569.163329905039, 577.6620676904058, 585.411661280419, 589.6167491130714, 523.5133117690968, 659.5877576514679, 684.5687217053224, 687.8830598798216, 696.7004188199123, 8770.298376129895, 9021.188093071654, 9227.76930576741, 9774.706758797247, 9882.555285012191, 560.0099292540648, 703.781827633425, 718.9748358807417, 722.9855402891912, 763.9006929099181, 3925.4896863407575, 4008.5390180129075, 4111.301078816608, 4210.136921930997, 4297.162053399619, 50334.49665503371, 51303.743481282356, 51571.0, 51648.0, 51827.0, 46746.0, 46944.0, 47147.76426117916, 47462.76268618635, 47715.76142119267, 42291.0, 42470.150596987885, 42659.36010959838, 42699.7865010673, 42801.35797963033, 8421.852427630914, 8455.788605284917, 8569.657213711382, 8636.0, 8643.91356086431, 32088.518672219467, 32295.0, 32474.02577922666, 32630.0, 32739.672603273662, 36891.446628301135, 37240.813795930844, 37515.81242093772, 41539.79230103951, 41619.167616648105, 10045.347052441568, 10047.145992590711, 10189.337693049929, 10511.316764410289, 10606.946965265124, 10876.836847447137, 11012.119030477383, 11014.559417623206, 11190.608328708457, 11256.83114753263, 10136.341137826017, 10262.127719143957, 10440.269181157246, 10675.092617127631, 10814.945925270324, 10149.898501014895, 10187.949060254652, 10311.0, 10486.528106235086, 10696.946515267375, 10308.381497110197, 10410.635627752992, 10450.372977621062, 10561.313514621525, 10697.732556686145, 8560.91439085601, 8584.399092063495, 8968.910310897068, 9135.90864091377, 9238.214751746176, 8913.777155570902, 8958.0, 8959.1936725695, 9041.547922603975, 9397.436153830791], "unit": "score", "name": "yui.html", "value": 6157.973463405862}], "name": "dromaeo_css", "value": 6826.974451587106}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 109.0, 110.0, 110.0, 102.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 153.0, 164.0, 134.0, 153.0, 150.0, 127.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 166.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 135.0, 95.0, 73.0, 74.0, 72.0, 118.0, 95.0, 72.0], "unit": "score", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 96.0, 95.0, 148.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 66.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 83.0, 82.0, 84.0, 84.0, 84.0, 84.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 121.0, 115.0, 114.0, 114.0, 120.0, 127.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [152.0, 139.0, 148.0, 151.0, 141.0, 143.0, 150.0, 144.0, 150.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 68.0, 68.0, 68.0, 68.0, 70.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1508.8999999999999}]} 05:22:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6826.97"}}} 05:22:54 INFO - Return code: 0 05:22:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:54 INFO - # TBPL SUCCESS # 05:22:54 INFO - Running post-action listener: _resource_record_post_action 05:22:54 INFO - Running post-run listener: _resource_record_post_run 05:22:55 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 550735872; Read time: 0; Write time: 606240 05:22:55 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 240091136; Read time: 0; Write time: 381140 05:22:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 298553344; Read time: 0; Write time: 220296 05:22:55 INFO - Running post-run listener: _upload_blobber_files 05:22:55 INFO - Blob upload gear active. 05:22:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:22:55 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:22:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:22:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:22:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:56 INFO - (blobuploader) - INFO - Done attempting. 05:22:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:58 INFO - (blobuploader) - INFO - Done attempting. 05:22:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:58 INFO - Return code: 0 05:22:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:22:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2763818957783a9362112c3e181c1a6599dffc99ca3adfc2f2f5886602a47e0c48b98cf733be6f85f0d3ede56d86f395de07067917e9d8e85a4b4137c4269b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b557dbbe1f3cab4e7016f577ac7d7e25993453f09f1990c45e8d8e937390e320d3e9ebb55537b8ec19cc9fb09f83850fe3658229b2c108049f9063c9e3d7908"} 05:22:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:22:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:22:58 INFO - Contents: 05:22:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2763818957783a9362112c3e181c1a6599dffc99ca3adfc2f2f5886602a47e0c48b98cf733be6f85f0d3ede56d86f395de07067917e9d8e85a4b4137c4269b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b557dbbe1f3cab4e7016f577ac7d7e25993453f09f1990c45e8d8e937390e320d3e9ebb55537b8ec19cc9fb09f83850fe3658229b2c108049f9063c9e3d7908"} 05:22:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:58 INFO - Copying logs to upload dir... 05:22:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:22:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.612771 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-11 05:22:57.861793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 05:22:57.865226) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2763818957783a9362112c3e181c1a6599dffc99ca3adfc2f2f5886602a47e0c48b98cf733be6f85f0d3ede56d86f395de07067917e9d8e85a4b4137c4269b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b557dbbe1f3cab4e7016f577ac7d7e25993453f09f1990c45e8d8e937390e320d3e9ebb55537b8ec19cc9fb09f83850fe3658229b2c108049f9063c9e3d7908"} build_url:https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/ZeyrmPOISB-v8xwwirjieA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2763818957783a9362112c3e181c1a6599dffc99ca3adfc2f2f5886602a47e0c48b98cf733be6f85f0d3ede56d86f395de07067917e9d8e85a4b4137c4269b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b557dbbe1f3cab4e7016f577ac7d7e25993453f09f1990c45e8d8e937390e320d3e9ebb55537b8ec19cc9fb09f83850fe3658229b2c108049f9063c9e3d7908"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 05:22:57.890649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:22:57.890966) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1455193665.549748-1636494034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003888 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:22:57.974769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 05:22:57.975107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 05:22:57.975416) ========= ========= Total master_lag: 0.30 =========