builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1450705015.33 results: success (0) buildid: 20151221023006 builduid: d0c8f46c991f4b7d90925449f31e193d revision: 1a11309e66f8139dccf73a2b1af43e09643d68bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.333643) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.334124) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.334468) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006390 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.359417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.359758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.379790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.380154) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025250 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.429273) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.429630) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.430019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.430339) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 05:36:55-- 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% 224M=0s 2015-12-21 05:36:55 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.632878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.633227) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.172750 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:55.820098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 05:36:55.820918) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 1a11309e66f8139dccf73a2b1af43e09643d68bb --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/b2g-inbound --rev 1a11309e66f8139dccf73a2b1af43e09643d68bb --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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 05:36:55,969 truncating revision to first 12 chars 2015-12-21 05:36:55,969 Setting DEBUG logging. 2015-12-21 05:36:55,969 attempt 1/10 2015-12-21 05:36:55,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/1a11309e66f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 05:36:56,867 unpacking tar archive at: b2g-inbound-1a11309e66f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.159548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 05:36:56.998419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:56.998781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:57.011096) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:57.011421) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:36:57.011857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-21 05:36:57.012181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:57 INFO - MultiFileLogger online at 20151221 05:36:57 in /builds/slave/test-pgo 05:36:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 05:36:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:36:57 INFO - {'append_to_log': False, 05:36:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:36:57 INFO - 'blob_upload_branch': 'B2G-Inbound', 05:36:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:36:57 INFO - 'branch': 'B2G-Inbound', 05:36:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:57 INFO - 'config_files': ('talos/linux_config.py',), 05:36:57 INFO - 'default_actions': ('clobber', 05:36:57 INFO - 'read-buildbot-config', 05:36:57 INFO - 'download-and-extract', 05:36:57 INFO - 'populate-webroot', 05:36:57 INFO - 'create-virtualenv', 05:36:57 INFO - 'install', 05:36:57 INFO - 'run-tests'), 05:36:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:57 INFO - 'download_minidump_stackwalk': True, 05:36:57 INFO - 'download_symbols': 'ondemand', 05:36:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:57 INFO - 'installer_path': 'installer.exe', 05:36:57 INFO - 'log_level': 'info', 05:36:57 INFO - 'log_name': 'talos', 05:36:57 INFO - 'log_to_console': True, 05:36:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:57 INFO - 'opt_config_files': (), 05:36:57 INFO - 'pip_index': False, 05:36:57 INFO - 'sps_profile': False, 05:36:57 INFO - 'sps_profile_interval': 0, 05:36:57 INFO - 'suite': 'dromaeojs', 05:36:57 INFO - 'system_bits': '64', 05:36:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:57 INFO - 'title': 'talos-linux64-ix-060', 05:36:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:57 INFO - 'use_talos_json': True, 05:36:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:36:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:57 INFO - 'work_dir': 'build'} 05:36:57 INFO - ##### 05:36:57 INFO - ##### Running clobber step. 05:36:57 INFO - ##### 05:36:57 INFO - Running pre-action listener: _resource_record_pre_action 05:36:57 INFO - Running main action method: clobber 05:36:57 INFO - rmtree: /builds/slave/test-pgo/build 05:36:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:37:01 INFO - Running post-action listener: _resource_record_post_action 05:37:01 INFO - ##### 05:37:01 INFO - ##### Running read-buildbot-config step. 05:37:01 INFO - ##### 05:37:01 INFO - Running pre-action listener: _resource_record_pre_action 05:37:01 INFO - Running main action method: read_buildbot_config 05:37:01 INFO - Using buildbot properties: 05:37:01 INFO - { 05:37:01 INFO - "project": "", 05:37:01 INFO - "product": "firefox", 05:37:01 INFO - "script_repo_revision": "production", 05:37:01 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:37:01 INFO - "repository": "", 05:37:01 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 05:37:01 INFO - "buildid": "20151221023006", 05:37:01 INFO - "pgo_build": "True", 05:37:01 INFO - "basedir": "/builds/slave/test-pgo", 05:37:01 INFO - "buildnumber": 136, 05:37:01 INFO - "slavename": "talos-linux64-ix-060", 05:37:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:37:01 INFO - "platform": "ubuntu64_hw", 05:37:01 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 05:37:01 INFO - "branch": "b2g-inbound", 05:37:01 INFO - "repo_path": "integration/b2g-inbound", 05:37:01 INFO - "revision": "1a11309e66f8139dccf73a2b1af43e09643d68bb", 05:37:01 INFO - "stage_platform": "linux64-pgo", 05:37:01 INFO - "builduid": "d0c8f46c991f4b7d90925449f31e193d", 05:37:01 INFO - "slavebuilddir": "test" 05:37:01 INFO - } 05:37:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:37:01 INFO - Running post-action listener: _resource_record_post_action 05:37:01 INFO - ##### 05:37:01 INFO - ##### Running download-and-extract step. 05:37:01 INFO - ##### 05:37:01 INFO - Running pre-action listener: _resource_record_pre_action 05:37:01 INFO - Running main action method: download_and_extract 05:37:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:37:01 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:37:01 INFO - https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:37:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/test_packages.json 05:37:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/test_packages.json 05:37:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:37:02 INFO - Downloaded 1302 bytes. 05:37:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:37:02 INFO - Using the following test package requirements: 05:37:02 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:02 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:02 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'jsshell-linux-x86_64.zip'], 05:37:02 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:02 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:02 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:02 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:02 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:02 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:02 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:02 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:37:02 INFO - https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:03 INFO - Downloaded 23121164 bytes. 05:37:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:37:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:37:04 INFO - Return code: 0 05:37:04 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:37:04 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:37:04 INFO - https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:05 INFO - Downloaded 23121164 bytes. 05:37:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:37:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:37:06 INFO - Return code: 0 05:37:06 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:37:06 INFO - https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:37:07 INFO - Downloaded 11132039 bytes. 05:37:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:37:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:37:07 INFO - Return code: 0 05:37:07 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:37:07 INFO - https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:37:09 INFO - Downloaded 54644978 bytes. 05:37:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:09 INFO - mkdir: /builds/slave/test-pgo/properties 05:37:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:37:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:37:09 INFO - Contents: 05:37:09 INFO - build_url:https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:09 INFO - Running post-action listener: _resource_record_post_action 05:37:09 INFO - Running post-action listener: set_extra_try_arguments 05:37:09 INFO - ##### 05:37:09 INFO - ##### Running populate-webroot step. 05:37:09 INFO - ##### 05:37:09 INFO - Running pre-action listener: _resource_record_pre_action 05:37:09 INFO - Running main action method: populate_webroot 05:37:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:09 INFO - '--tppagecycles', 05:37:09 INFO - '7'], 05:37:09 INFO - 'tests': ['tsvgm']}}, 05:37:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:37:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'tests': ['damp', 'tps']}, 05:37:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['damp', 'tps']}, 05:37:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:37:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:09 INFO - 'other': {'tests': ['a11yr', 05:37:09 INFO - 'ts_paint', 05:37:09 INFO - 'tpaint', 05:37:09 INFO - 'sessionrestore', 05:37:09 INFO - 'sessionrestore_no_auto_restore']}, 05:37:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['a11yr', 05:37:09 INFO - 'ts_paint', 05:37:09 INFO - 'tpaint', 05:37:09 INFO - 'sessionrestore', 05:37:09 INFO - 'sessionrestore_no_auto_restore']}, 05:37:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['a11yr', 05:37:09 INFO - 'ts_paint', 05:37:09 INFO - 'tpaint', 05:37:09 INFO - 'sessionrestore', 05:37:09 INFO - 'sessionrestore_no_auto_restore']}, 05:37:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['a11yr', 05:37:09 INFO - 'ts_paint', 05:37:09 INFO - 'tpaint', 05:37:09 INFO - 'sessionrestore', 05:37:09 INFO - 'sessionrestore_no_auto_restore']}, 05:37:09 INFO - 'other_l64': {'tests': ['a11yr', 05:37:09 INFO - 'ts_paint', 05:37:09 INFO - 'tpaint', 05:37:09 INFO - 'sessionrestore', 05:37:09 INFO - 'sessionrestore_no_auto_restore']}, 05:37:09 INFO - 'other_nol64': {'tests': ['a11yr', 05:37:09 INFO - 'ts_paint', 05:37:09 INFO - 'tpaint', 05:37:09 INFO - 'sessionrestore', 05:37:09 INFO - 'sessionrestore_no_auto_restore']}, 05:37:09 INFO - 'svgr': {'tests': ['tsvgx', 05:37:09 INFO - 'tsvgr_opacity', 05:37:09 INFO - 'tart', 05:37:09 INFO - 'tscrollx', 05:37:09 INFO - 'cart']}, 05:37:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['tsvgx', 05:37:09 INFO - 'tsvgr_opacity', 05:37:09 INFO - 'tart', 05:37:09 INFO - 'tscrollx', 05:37:09 INFO - 'cart']}, 05:37:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'tests': ['tp5o']}, 05:37:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'talos_options': ['--e10s'], 05:37:09 INFO - 'tests': ['tp5o']}, 05:37:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'talos_options': ['--xperf_path', 05:37:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:09 INFO - 'tests': ['tp5n']}, 05:37:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:09 INFO - 'talos_options': ['--e10s', 05:37:09 INFO - '--xperf_path', 05:37:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:09 INFO - 'tests': ['tp5n']}}, 05:37:09 INFO - 'talos.zip': {'path': '', 05:37:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:09 INFO - Running post-action listener: _resource_record_post_action 05:37:09 INFO - ##### 05:37:09 INFO - ##### Running create-virtualenv step. 05:37:09 INFO - ##### 05:37:09 INFO - Running pre-action listener: _resource_record_pre_action 05:37:09 INFO - Running main action method: create_virtualenv 05:37:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:37:09 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:37:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:37:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:09 INFO - Using real prefix '/usr' 05:37:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:37:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:11 INFO - Installing pip.................done. 05:37:11 INFO - Return code: 0 05:37:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:37:11 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:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:11 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:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:11 INFO - Using env: {'DISPLAY': ':0', 05:37:11 INFO - 'HOME': '/home/cltbld', 05:37:11 INFO - 'LANG': 'en_US.UTF-8', 05:37:11 INFO - 'LANGUAGE': 'en_US:en', 05:37:11 INFO - 'LOGNAME': 'cltbld', 05:37:11 INFO - 'MAIL': '/var/mail/cltbld', 05:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:11 INFO - 'MOZ_NO_REMOTE': '1', 05:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:11 INFO - 'NO_EM_RESTART': '1', 05:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:11 INFO - 'SHELL': '/bin/bash', 05:37:11 INFO - 'SHLVL': '1', 05:37:11 INFO - 'TERM': 'linux', 05:37:11 INFO - 'TMOUT': '86400', 05:37:11 INFO - 'USER': 'cltbld', 05:37:11 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:11 INFO - '_': '/tools/buildbot/bin/python'} 05:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:12 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:37:12 INFO - Cleaning up... 05:37:12 INFO - Return code: 0 05:37:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:37:12 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:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:12 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:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:12 INFO - Using env: {'DISPLAY': ':0', 05:37:12 INFO - 'HOME': '/home/cltbld', 05:37:12 INFO - 'LANG': 'en_US.UTF-8', 05:37:12 INFO - 'LANGUAGE': 'en_US:en', 05:37:12 INFO - 'LOGNAME': 'cltbld', 05:37:12 INFO - 'MAIL': '/var/mail/cltbld', 05:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:12 INFO - 'MOZ_NO_REMOTE': '1', 05:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:12 INFO - 'NO_EM_RESTART': '1', 05:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:12 INFO - 'SHELL': '/bin/bash', 05:37:12 INFO - 'SHLVL': '1', 05:37:12 INFO - 'TERM': 'linux', 05:37:12 INFO - 'TMOUT': '86400', 05:37:12 INFO - 'USER': 'cltbld', 05:37:12 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:12 INFO - '_': '/tools/buildbot/bin/python'} 05:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:12 INFO - Downloading/unpacking psutil>=0.7.1 05:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:37:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:37:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:14 INFO - Installing collected packages: psutil 05:37:14 INFO - Running setup.py install for psutil 05:37:14 INFO - building 'psutil._psutil_linux' extension 05:37:14 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:37:14 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:37:14 INFO - building 'psutil._psutil_posix' extension 05:37:14 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:37:14 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:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:14 INFO - Successfully installed psutil 05:37:14 INFO - Cleaning up... 05:37:14 INFO - Return code: 0 05:37:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:37:14 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:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:14 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:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:14 INFO - Using env: {'DISPLAY': ':0', 05:37:14 INFO - 'HOME': '/home/cltbld', 05:37:14 INFO - 'LANG': 'en_US.UTF-8', 05:37:14 INFO - 'LANGUAGE': 'en_US:en', 05:37:14 INFO - 'LOGNAME': 'cltbld', 05:37:14 INFO - 'MAIL': '/var/mail/cltbld', 05:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:14 INFO - 'MOZ_NO_REMOTE': '1', 05:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:14 INFO - 'NO_EM_RESTART': '1', 05:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:14 INFO - 'SHELL': '/bin/bash', 05:37:14 INFO - 'SHLVL': '1', 05:37:14 INFO - 'TERM': 'linux', 05:37:14 INFO - 'TMOUT': '86400', 05:37:14 INFO - 'USER': 'cltbld', 05:37:14 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:14 INFO - '_': '/tools/buildbot/bin/python'} 05:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:37:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:37:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:16 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:37:16 INFO - Installing collected packages: mozsystemmonitor 05:37:16 INFO - Running setup.py install for mozsystemmonitor 05:37:16 INFO - Successfully installed mozsystemmonitor 05:37:16 INFO - Cleaning up... 05:37:16 INFO - Return code: 0 05:37:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:37:16 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:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:16 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:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:16 INFO - Using env: {'DISPLAY': ':0', 05:37:16 INFO - 'HOME': '/home/cltbld', 05:37:16 INFO - 'LANG': 'en_US.UTF-8', 05:37:16 INFO - 'LANGUAGE': 'en_US:en', 05:37:16 INFO - 'LOGNAME': 'cltbld', 05:37:16 INFO - 'MAIL': '/var/mail/cltbld', 05:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:16 INFO - 'MOZ_NO_REMOTE': '1', 05:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:16 INFO - 'NO_EM_RESTART': '1', 05:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:16 INFO - 'SHELL': '/bin/bash', 05:37:16 INFO - 'SHLVL': '1', 05:37:16 INFO - 'TERM': 'linux', 05:37:16 INFO - 'TMOUT': '86400', 05:37:16 INFO - 'USER': 'cltbld', 05:37:16 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:16 INFO - '_': '/tools/buildbot/bin/python'} 05:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:16 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:37:16 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:37:16 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:37:16 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:37:16 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:37:16 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:37:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:37:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:37:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:37:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:19 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:37:19 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:37:19 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:37:19 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:37:19 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:37:19 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:37:19 INFO - Downloading docopt-0.6.1.tar.gz 05:37:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:37:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:19 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:19 INFO - Running setup.py install for blobuploader 05:37:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:37:19 INFO - Running setup.py install for requests 05:37:19 INFO - Running setup.py install for docopt 05:37:19 INFO - Successfully installed blobuploader requests docopt 05:37:19 INFO - Cleaning up... 05:37:19 INFO - Return code: 0 05:37:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37: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:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:19 INFO - Using env: {'DISPLAY': ':0', 05:37:19 INFO - 'HOME': '/home/cltbld', 05:37:19 INFO - 'LANG': 'en_US.UTF-8', 05:37:19 INFO - 'LANGUAGE': 'en_US:en', 05:37:19 INFO - 'LOGNAME': 'cltbld', 05:37:19 INFO - 'MAIL': '/var/mail/cltbld', 05:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:19 INFO - 'MOZ_NO_REMOTE': '1', 05:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:19 INFO - 'NO_EM_RESTART': '1', 05:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:19 INFO - 'SHELL': '/bin/bash', 05:37:19 INFO - 'SHLVL': '1', 05:37:19 INFO - 'TERM': 'linux', 05:37:19 INFO - 'TMOUT': '86400', 05:37:19 INFO - 'USER': 'cltbld', 05:37:19 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:19 INFO - '_': '/tools/buildbot/bin/python'} 05:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:20 INFO - Running setup.py (path:/tmp/pip-974h_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:20 INFO - Running setup.py (path:/tmp/pip-GF5CyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:20 INFO - Running setup.py (path:/tmp/pip-TR309D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:20 INFO - Running setup.py (path:/tmp/pip-pRMTzE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:20 INFO - Running setup.py (path:/tmp/pip-v432Vu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:20 INFO - Running setup.py (path:/tmp/pip-1se3DD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:20 INFO - Running setup.py (path:/tmp/pip-lSroRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:20 INFO - Running setup.py (path:/tmp/pip-8Gp3Ok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:20 INFO - Running setup.py (path:/tmp/pip-4RnLNm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:20 INFO - Running setup.py (path:/tmp/pip-LHydeT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:20 INFO - Running setup.py (path:/tmp/pip-31mRRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:20 INFO - Running setup.py (path:/tmp/pip-HNmVHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:21 INFO - Running setup.py (path:/tmp/pip-_JsduU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:21 INFO - Running setup.py (path:/tmp/pip-vlUky2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:21 INFO - Running setup.py (path:/tmp/pip-K2Xi9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:21 INFO - Running setup.py (path:/tmp/pip-3lwjoM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:21 INFO - Running setup.py (path:/tmp/pip-VwS9Rk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:21 INFO - Running setup.py install for manifestparser 05:37:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:37:21 INFO - Running setup.py install for mozcrash 05:37:21 INFO - Running setup.py install for mozdebug 05:37:21 INFO - Running setup.py install for mozdevice 05:37:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:37:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:37:21 INFO - Running setup.py install for mozfile 05:37:21 INFO - Running setup.py install for mozhttpd 05:37:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:37:21 INFO - Running setup.py install for mozinfo 05:37:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Running setup.py install for mozInstall 05:37:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Running setup.py install for mozleak 05:37:22 INFO - Running setup.py install for mozlog 05:37:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Running setup.py install for moznetwork 05:37:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Running setup.py install for mozprocess 05:37:22 INFO - Running setup.py install for mozprofile 05:37:22 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Running setup.py install for mozrunner 05:37:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:37:22 INFO - Running setup.py install for mozscreenshot 05:37:22 INFO - Running setup.py install for moztest 05:37:23 INFO - Running setup.py install for mozversion 05:37:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:37:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:23 INFO - Cleaning up... 05:37:23 INFO - Return code: 0 05:37:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37:23 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:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:23 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:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:23 INFO - Using env: {'DISPLAY': ':0', 05:37:23 INFO - 'HOME': '/home/cltbld', 05:37:23 INFO - 'LANG': 'en_US.UTF-8', 05:37:23 INFO - 'LANGUAGE': 'en_US:en', 05:37:23 INFO - 'LOGNAME': 'cltbld', 05:37:23 INFO - 'MAIL': '/var/mail/cltbld', 05:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:23 INFO - 'MOZ_NO_REMOTE': '1', 05:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:23 INFO - 'NO_EM_RESTART': '1', 05:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:23 INFO - 'SHELL': '/bin/bash', 05:37:23 INFO - 'SHLVL': '1', 05:37:23 INFO - 'TERM': 'linux', 05:37:23 INFO - 'TMOUT': '86400', 05:37:23 INFO - 'USER': 'cltbld', 05:37:23 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:23 INFO - '_': '/tools/buildbot/bin/python'} 05:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:23 INFO - Running setup.py (path:/tmp/pip-zrQH7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:23 INFO - Running setup.py (path:/tmp/pip-3vVhMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:23 INFO - Running setup.py (path:/tmp/pip-qzlCq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:23 INFO - Running setup.py (path:/tmp/pip-T9ZYM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:23 INFO - Running setup.py (path:/tmp/pip-QtkrOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:23 INFO - Running setup.py (path:/tmp/pip-i6mtfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:23 INFO - Running setup.py (path:/tmp/pip-XMC2QR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:23 INFO - Running setup.py (path:/tmp/pip-J9axkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:23 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:37:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:23 INFO - Running setup.py (path:/tmp/pip-UV7hWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:24 INFO - Running setup.py (path:/tmp/pip-fh5hup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:24 INFO - Running setup.py (path:/tmp/pip-FtPJ7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:24 INFO - Running setup.py (path:/tmp/pip-PMEwJT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:24 INFO - Running setup.py (path:/tmp/pip-SpkZ7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:24 INFO - Running setup.py (path:/tmp/pip-nAHntN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:24 INFO - Running setup.py (path:/tmp/pip-NzL34m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:24 INFO - Running setup.py (path:/tmp/pip-TreUTm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:24 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:37:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:24 INFO - Running setup.py (path:/tmp/pip-5LDvAm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:24 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:37:24 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:37:24 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:37:24 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:37:24 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:24 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:24 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:37:24 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:37:24 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:37:24 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:37:24 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:37:24 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:37:26 INFO - Downloading blessings-1.5.1.tar.gz 05:37:26 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:37:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:26 INFO - Installing collected packages: blessings 05:37:26 INFO - Running setup.py install for blessings 05:37:26 INFO - Successfully installed blessings 05:37:26 INFO - Cleaning up... 05:37:26 INFO - Return code: 0 05:37:26 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:37:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:37:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:37:26 INFO - Reading from file tmpfile_stdout 05:37:26 INFO - Current package versions: 05:37:26 INFO - argparse == 1.2.1 05:37:26 INFO - blessings == 1.5.1 05:37:26 INFO - blobuploader == 1.2.4 05:37:26 INFO - docopt == 0.6.1 05:37:26 INFO - manifestparser == 1.1 05:37:26 INFO - mozInstall == 1.12 05:37:26 INFO - mozcrash == 0.16 05:37:26 INFO - mozdebug == 0.1 05:37:26 INFO - mozdevice == 0.47 05:37:26 INFO - mozfile == 1.2 05:37:26 INFO - mozhttpd == 0.7 05:37:26 INFO - mozinfo == 0.9 05:37:26 INFO - mozleak == 0.1 05:37:26 INFO - mozlog == 3.1 05:37:26 INFO - moznetwork == 0.27 05:37:26 INFO - mozprocess == 0.22 05:37:26 INFO - mozprofile == 0.27 05:37:26 INFO - mozrunner == 6.11 05:37:26 INFO - mozscreenshot == 0.1 05:37:26 INFO - mozsystemmonitor == 0.0 05:37:26 INFO - moztest == 0.7 05:37:26 INFO - mozversion == 1.4 05:37:26 INFO - psutil == 3.1.1 05:37:26 INFO - requests == 1.2.3 05:37:26 INFO - wsgiref == 0.1.2 05:37:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37:26 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:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 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:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:26 INFO - Using env: {'DISPLAY': ':0', 05:37:26 INFO - 'HOME': '/home/cltbld', 05:37:26 INFO - 'LANG': 'en_US.UTF-8', 05:37:26 INFO - 'LANGUAGE': 'en_US:en', 05:37:26 INFO - 'LOGNAME': 'cltbld', 05:37:26 INFO - 'MAIL': '/var/mail/cltbld', 05:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:26 INFO - 'MOZ_NO_REMOTE': '1', 05:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:26 INFO - 'NO_EM_RESTART': '1', 05:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:26 INFO - 'SHELL': '/bin/bash', 05:37:26 INFO - 'SHLVL': '1', 05:37:26 INFO - 'TERM': 'linux', 05:37:26 INFO - 'TMOUT': '86400', 05:37:26 INFO - 'USER': 'cltbld', 05:37:26 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:26 INFO - '_': '/tools/buildbot/bin/python'} 05:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:26 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 1)) 05:37:26 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 2)) 05:37:26 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 3)) 05:37:26 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 4)) 05:37:26 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 5)) 05:37:26 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 6)) 05:37:26 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 7)) 05:37:26 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 8)) 05:37:26 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:37:26 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 3)) 05:37:26 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:37:26 INFO - Cleaning up... 05:37:26 INFO - Return code: 0 05:37:26 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:37:26 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:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 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:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:26 INFO - Using env: {'DISPLAY': ':0', 05:37:26 INFO - 'HOME': '/home/cltbld', 05:37:26 INFO - 'LANG': 'en_US.UTF-8', 05:37:26 INFO - 'LANGUAGE': 'en_US:en', 05:37:26 INFO - 'LOGNAME': 'cltbld', 05:37:26 INFO - 'MAIL': '/var/mail/cltbld', 05:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:26 INFO - 'MOZ_NO_REMOTE': '1', 05:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:26 INFO - 'NO_EM_RESTART': '1', 05:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:26 INFO - 'SHELL': '/bin/bash', 05:37:26 INFO - 'SHLVL': '1', 05:37:26 INFO - 'TERM': 'linux', 05:37:26 INFO - 'TMOUT': '86400', 05:37:26 INFO - 'USER': 'cltbld', 05:37:26 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:26 INFO - '_': '/tools/buildbot/bin/python'} 05:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:27 INFO - Downloading/unpacking jsonschema 05:37:27 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:37:27 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:37:27 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:37:27 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:37:27 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:37:27 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:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:37:28 INFO - Downloading/unpacking functools32 (from jsonschema) 05:37:28 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:37:28 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:37:28 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:37:28 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:37:28 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:37:28 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:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:37:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:29 INFO - warning: no files found matching '*.txt' 05:37:29 INFO - no previously-included directories found matching 'build' 05:37:29 INFO - no previously-included directories found matching 'dist' 05:37:29 INFO - no previously-included directories found matching '.git*' 05:37:29 INFO - Installing collected packages: jsonschema, functools32 05:37:29 INFO - Running setup.py install for functools32 05:37:29 INFO - warning: no files found matching '*.txt' 05:37:29 INFO - no previously-included directories found matching 'build' 05:37:29 INFO - no previously-included directories found matching 'dist' 05:37:29 INFO - no previously-included directories found matching '.git*' 05:37:29 INFO - Successfully installed jsonschema functools32 05:37:29 INFO - Cleaning up... 05:37:29 INFO - Return code: 0 05:37:29 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:37:29 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:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:29 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:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f4e601e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1def600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', '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:37:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:37:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:37:29 INFO - Using env: {'DISPLAY': ':0', 05:37:29 INFO - 'HOME': '/home/cltbld', 05:37:29 INFO - 'LANG': 'en_US.UTF-8', 05:37:29 INFO - 'LANGUAGE': 'en_US:en', 05:37:29 INFO - 'LOGNAME': 'cltbld', 05:37:29 INFO - 'MAIL': '/var/mail/cltbld', 05:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:29 INFO - 'MOZ_NO_REMOTE': '1', 05:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:29 INFO - 'NO_EM_RESTART': '1', 05:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:29 INFO - 'SHELL': '/bin/bash', 05:37:29 INFO - 'SHLVL': '1', 05:37:29 INFO - 'TERM': 'linux', 05:37:29 INFO - 'TMOUT': '86400', 05:37:29 INFO - 'USER': 'cltbld', 05:37:29 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:29 INFO - '_': '/tools/buildbot/bin/python'} 05:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:29 INFO - Downloading/unpacking flake8 05:37:29 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:37:29 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:37:29 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:37:29 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:37:29 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:37:29 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:37:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:37:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:37:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:37:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:37:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:37:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:37:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:31 INFO - no previously-included directories found matching 'docs/_build' 05:37:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:37:31 INFO - Running setup.py install for pep8 05:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:31 INFO - no previously-included directories found matching 'docs/_build' 05:37:32 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:37:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:37:32 INFO - Cleaning up... 05:37:32 INFO - Return code: 0 05:37:32 INFO - Running post-action listener: _resource_record_post_action 05:37:32 INFO - Running post-action listener: _start_resource_monitoring 05:37:32 INFO - Starting resource monitoring. 05:37:32 INFO - ##### 05:37:32 INFO - ##### Running install step. 05:37:32 INFO - ##### 05:37:32 INFO - Running pre-action listener: _resource_record_pre_action 05:37:32 INFO - Running main action method: install 05:37:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:37:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:37:32 INFO - Reading from file tmpfile_stdout 05:37:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:37:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:37:32 INFO - Reading from file tmpfile_stdout 05:37:32 INFO - Output received: 05:37:32 INFO - Usage: mozinstall [options] installer 05:37:32 INFO - Options: 05:37:32 INFO - -h, --help show this help message and exit 05:37:32 INFO - -d DEST, --destination=DEST 05:37:32 INFO - Directory to install application into. [default: 05:37:32 INFO - "/builds/slave/test-pgo"] 05:37:32 INFO - --app=APP Application being installed. [default: firefox] 05:37:32 INFO - mkdir: /builds/slave/test-pgo/build/application 05:37:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:37:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:37:48 INFO - Reading from file tmpfile_stdout 05:37:48 INFO - Output received: 05:37:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:37:48 INFO - Running post-action listener: _resource_record_post_action 05:37:48 INFO - ##### 05:37:48 INFO - ##### Running run-tests step. 05:37:48 INFO - ##### 05:37:48 INFO - Running pre-action listener: _resource_record_pre_action 05:37:48 INFO - Running main action method: run_tests 05:37:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:37:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:37:48 INFO - Python 2.7.3 05:37:48 INFO - Return code: 0 05:37:48 INFO - grabbing minidump binary from tooltool 05:37:48 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:37:48 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 0x1e7e350>, '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 0x1e7f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:37:48 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:37:48 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:37:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:48 INFO - Return code: 0 05:37:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:37:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:37:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:37:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:37:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:37:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:37:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:37:49 INFO - Return code: 0 05:37:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:37:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 05:37:49 INFO - Using env: {'DISPLAY': ':0', 05:37:49 INFO - 'HOME': '/home/cltbld', 05:37:49 INFO - 'LANG': 'en_US.UTF-8', 05:37:49 INFO - 'LANGUAGE': 'en_US:en', 05:37:49 INFO - 'LOGNAME': 'cltbld', 05:37:49 INFO - 'MAIL': '/var/mail/cltbld', 05:37:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:37:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:49 INFO - 'MOZ_NO_REMOTE': '1', 05:37:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:49 INFO - 'NO_EM_RESTART': '1', 05:37:49 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:49 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:37:49 INFO - 'SHELL': '/bin/bash', 05:37:49 INFO - 'SHLVL': '1', 05:37:49 INFO - 'TERM': 'linux', 05:37:49 INFO - 'TMOUT': '86400', 05:37:49 INFO - 'USER': 'cltbld', 05:37:49 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706', 05:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:49 INFO - '_': '/tools/buildbot/bin/python'} 05:37:49 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 05:37:49 INFO - mozversion INFO | application_buildid: 20151221023006 05:37:49 INFO - mozversion INFO | application_changeset: 1a11309e66f8139dccf73a2b1af43e09643d68bb 05:37:49 INFO - mozversion INFO | application_display_name: Nightly 05:37:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:49 INFO - mozversion INFO | application_name: Firefox 05:37:49 INFO - mozversion INFO | application_remotingname: firefox 05:37:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:37:49 INFO - mozversion INFO | application_vendor: Mozilla 05:37:49 INFO - mozversion INFO | application_version: 46.0a1 05:37:49 INFO - mozversion INFO | platform_buildid: 20151221023006 05:37:49 INFO - mozversion INFO | platform_changeset: 1a11309e66f8139dccf73a2b1af43e09643d68bb 05:37:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:37:49 INFO - mozversion INFO | platform_version: 46.0a1 05:37:49 INFO - 2015-12-21 05:37:49,358 DEBUG : using testdate: 1450705069 05:37:49 INFO - 2015-12-21 05:37:49,358 DEBUG : actual date: 1450705069 05:37:49 INFO - 2015-12-21 05:37:49,368 INFO : starting webserver on 'localhost:46359' 05:37:49 INFO - 2015-12-21 05:37:49,369 INFO : Starting test suite talos-linux64-ix-060 05:37:49 INFO - 2015-12-21 05:37:49,369 INFO : Starting test dromaeo_css 05:37:49 INFO - 2015-12-21 05:37:49,369 DEBUG : operating with platform_type : linux_ 05:37:49 INFO - 2015-12-21 05:37:49,370 INFO : Initialising browser for dromaeo_css test... 05:37:49 INFO - 2015-12-21 05:37:49,386 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnt3Awr/profile http://localhost:46359/getInfo.html 05:37:53 INFO - 2015-12-21 05:37:53,530 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:37:53 INFO - 2015-12-21 05:37:53,530 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:37:53 INFO - 2015-12-21 05:37:53,530 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:37:53 INFO - 2015-12-21 05:37:53,530 DEBUG : BROWSER_OUTPUT: __metrics 05:37:53 INFO - 2015-12-21 05:37:53,578 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:37:53 INFO - 2015-12-21 05:37:53,646 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:54 INFO - 2015-12-21 05:37:54,554 INFO : Browser initialized. 05:37:54 INFO - 2015-12-21 05:37:54,555 INFO : Running cycle 1/1 for dromaeo_css test... 05:37:54 INFO - 2015-12-21 05:37:54,555 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnt3Awr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:38:06 INFO - 2015-12-21 05:38:06,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 149827584 05:38:06 INFO - 2015-12-21 05:38:06,348 DEBUG : BROWSER_OUTPUT: 05:38:57 INFO - 2015-12-21 05:38:57,835 DEBUG : BROWSER_OUTPUT: 1450705137834 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:41:06 INFO - 2015-12-21 05:41:06,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46359/tests/dromaeo/cssquery-ext.html) 05:41:07 INFO - 2015-12-21 05:41:07,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 272211968 05:41:07 INFO - 2015-12-21 05:41:07,550 DEBUG : BROWSER_OUTPUT: 05:44:10 INFO - 2015-12-21 05:44:10,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/dromaeo/cssquery-ext.html (next: http://localhost:46359/tests/dromaeo/cssquery-jquery.html) 05:44:10 INFO - 2015-12-21 05:44:10,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 227713024 05:44:10 INFO - 2015-12-21 05:44:10,576 DEBUG : BROWSER_OUTPUT: 05:47:12 INFO - 2015-12-21 05:47:12,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46359/tests/dromaeo/cssquery-mootools.html) 05:47:13 INFO - 2015-12-21 05:47:13,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 220434432 05:47:13 INFO - 2015-12-21 05:47:13,086 DEBUG : BROWSER_OUTPUT: 05:50:14 INFO - 2015-12-21 05:50:14,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46359/tests/dromaeo/cssquery-prototype.html) 05:50:15 INFO - 2015-12-21 05:50:15,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 210358272 05:50:15 INFO - 2015-12-21 05:50:15,551 DEBUG : BROWSER_OUTPUT: 05:53:18 INFO - 2015-12-21 05:53:18,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46359/tests/dromaeo/cssquery-yui.html) 05:53:18 INFO - 2015-12-21 05:53:18,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 214151168 05:53:18 INFO - 2015-12-21 05:53:18,628 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/dromaeo/cssquery-yui.html (next: http://localhost:46359/tests/dromaeo/cssquery-dojo.html) 05:56:21 INFO - 2015-12-21 05:56:21,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 284229632 05:56:21 INFO - 2015-12-21 05:56:21,513 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,513 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:21 INFO - 2015-12-21 05:56:21,513 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:21 INFO - 2015-12-21 05:56:21,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:21 INFO - 2015-12-21 05:56:21,514 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:21 INFO - 2015-12-21 05:56:21,514 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3130.2017985413718;3151.1019359482525;3206.519022146678;3211.020638705194;3237.239248776537;5144.0740666679985;5261.1319132343215;5285.101532739434;5325.20121981703;5380.246765452835;5210.921836172451;5237.188235823444;5248.47515248475;5336.199570064492;5451.073317536018;4801.759912004403;4812.23004319309;4835.588974937117;4877.219644856824;4971.751412429382;4710.387649605546;4954.380702412199;4977.950220497803;4995.150824359867;5034.496550344973;4743.549362810528;4762.4046994125565;4796.472388037313;4806.158922188638;4813.374261346003;4858.659893807435;4862.124817532843;4864.464908860023;4870.391201099863;4886.877828054292;4698.38920940279;4827.131116399047;4836.927446088312;4854.757262136879;4911.435184953741;5081.568066714333;5125.282460455539;5149.76826042829;5168.5606723428555;5206.713630750307;5652;5660.66036037835;5666.291713535808;5669.319681638189;5707.857303567444;5530.2810634617645;5644.068728659766;5699.886002279973;5715.142728590703;5718.113692377647;4911.582515486188;5312.814051508179;5318.547923426513;5352.063388907003;5379.408265090837;5853.590248682552;5926.051831706906;5927.555433342516;5933.643981361132;5938.198343223609;5356.812511562077;5456;5653.491185793298;5687.260656114679;5700.486956173964;5591.552675786009;5606.439356064361;5654.264945557051;5664.037113690682;5713.200151978726;5639.464250896158;5652.208690783294;5683.976884160891;5684.573656975744;5688.431156884361;5450.182472629137;5548.69482178484;5676.432356764373;5677.347105082886;5688.260526131659;4366;4373.343998400265;4426.070525189682;4448.421705178371;4462.308342206963;3857.9421308680394;3865.594112618191;3876.3604005338802;3912.8043597820565;3916.7649941003633;5150.793968241303;5250.842474725764;5300.44345343741;5314.867128321823;5356.3572371315695;5642.210090587321;5703.372629010805;5720.971395143081;5747.453991870766;5778.88442231153;5401.972990135024;5431.728413579305;5438.564914806806;5444.945550544523;5454.509094181542;4856.538628830255;4959.752012399365;5048.545630893237;5062.088824011639;5112.769925353368;5713.657180569179;5738.655680659173;5846.0646296593195;5861.501772349313;5901.3508514063415;5669.858253543694;5670.829875103754;5672.971635141798;5675.574331925205;5680.829575112753;5579.442055794388;5703.857403564944;5737.684427356536;5762.1068734346245;5776.393478684678;5596.664200148004;5651.4348565143155;5715.31416230055;5718.51392631631;5773.1051686988585;5777.537796976316;5800.361960184461;5809.622374545641;5813.244278243801;5813.738381772746;5441.809536666197;5535.806246781343;5661.830145095653;5667.886642267049;5677.034904066401;5488.506034456918;5551.8889622208135;5567.498925096761;5570.693611851387;5588.441155884379;5423.945760542344;5427.185922111715;5429.321334833146;5430.972845135749;5461.9180712290145;5463.672179669074;5508.11870100798;5513.338399392099;5606.355269144101;5622.7750889963945;5309.203619457112;5359.839204823861;5361.437049109787;5363.329583802025;5384.946150538444 05:56:21 INFO - 2015-12-21 05:56:21,514 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.1209594888053;575.5136909311631;597.169933792029;610.2280615021995;611.1871211288985;30522.694773052262;31030.06909792707;31032.37935241294;37503;38103.80948095256;41814.79092604533;42346.788266058706;42374;42468.362974555406;42471.72584822452;8679.17547832955;8833.95583022084;8836.248918841906;8836.955815220916;8845.336599755012;7677.500962437423;7830.373570114377;10245.129164021067;10627.256092073558;10641.840372394421;10248.641297554586;10342.965703429672;10407.635732749355;10416.114630256438;10426.061654451098;7603.163651998276;7730.381569474484;10262.460630905349;10370.844437333446;10373.222008349367;10339.431331276777;10557.9472102639;10581;10612.469376531142;10616.150707943347;39385.21229575421;39985;40031.39952900709;40072.39891401602;40126.39810402846;3032.863521141554;3227.5320078588707;3767.571509925954;3777.7544459610035;3881.6506514413836;29534.409311813644;30136.54795178074;30171.547426788617;30203.31848563476;30253.546196807067;3889.2221555688975;3945.6646185074305;3974.7813870237123;4015.9397609035886;4042.3734321180264;266814;267607;268030;268463;269669;52255.25192228852;52860;58621.413785861594;59576.10635840466;59619.70190149022;59847.40152598506;59886.70056649689;60099;60107.398926011054;60109.69945150246;13425.865741342657;13446.529371471952;13457.192568445924;13522.864771352357;13531.120477168952;9787.706368808947;9842.557084931195;9879.11088002069;9920.4543750093;9984.301098923152;19394.92706531616;19609.607807843764;19647.60704785925;19726.70409943852;19746.40760777179;7214.206437291894;7361.447891408166;7425.740099096506;7436.814079648052;7436.925630743732;920.9447433154032;988.2588058955783;1024.9231307651955;1049.302214027663;1057.5135437698746;28296.292592684935;28919;29215.269618259288;29269.268268293035;31241.843790780902;960.356561104048;979.299800642544;997.5660587644398;1010.7877345757327;1018.149844879519;13715.451381944611;13901.79147312791;14081.2959352032;14099.929500352433;14125.293735313193;307136;309359;309522;309720;310563;51510.22734658983;51660;51703;51787.223191652156;51854.22218666723;1332.6801567623895;1343.4156142078227;1351.594521643503;1351.7904724767677;1359.2252416122715;25395.74604254008;25925.740742592334;26587.468250635266;26996.1901142966;27069.86465067662;42914;43322.350164746924;43359;43370.566294337914;43493.78253108714;195156;195494;196441;196698;197153;27609.585856212576;27981;31004.68995310018;31723.20691982719;32192.517112242866;37429.62570374261;37812.62187378091;37964.62035379611;38268.61731382651;38280.80859595684;32421;32490.51264230991;32911.886014248215;33082;35641.1089722759;30652.693473064985;31381.529277060406;33858.49212261867;35532.289354212255;36935.815320923226;33220;33270.83364583162;33561.49657755184;35787.28425431425;36147.0963225911;28776.424471510873;31495.212619683774;32294;32453.51319730159;32480.675193247764;24594.38514037092;25305.87347063253;25625.359366016;26682.866585666947;26820.59769103426 05:56:21 INFO - 2015-12-21 05:56:21,515 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.53380635432626;345.2731999141806;346.1294843468677;346.2054584728049;346.61179478983536;14163.929180354084;14463.92768036161;16102.67794644108;16602.667946641075;18142.90928545357;16131.516054518353;16263.51209463715;16816;17214.13929303533;17229.05240211788;5317.41508434072;5437.592180586452;5438.456154384549;5442.047641662713;5444.292242008553;3940.6059394060508;4006.1386801837743;5385.67685938843;5827;6030.969845150768;5929.318128415244;5957.553183511232;5958.702064896759;5975.671338076404;5979.222701048858;5807;5933.436323549256;5965.105234214859;5974.581779275452;5987.0420732683;5155.9484405155845;5220.660657057279;5224.164133738584;5257.106291930381;5273.762680679379;20492;20526.38420847377;20630.793692063187;21193.894030529904;21253.36239912805;2003.3589251439546;2040.3062958594148;2135.7757435469207;2167.0789914286524;2587.0815860369676;12945.158564693358;13041.934790326082;13146.539871104465;13235.139715918434;13482.988775841852;1831.716084006981;1838.218757028271;1841.815818418161;1869.7475840761458;1911.0826803134573;58418.973513397934;62313.376866231214;62449.06326405153;62456;62733;9158.86261706075;9229.584668689926;9376.296777741696;9397.201237894718;9424.198943089777;12046;12066.69833254158;12091.334976576196;12094.730053344272;12108.939455302843;7220.3140701633265;7233.782986510413;7296.124465064227;7321.597312147883;7391.926080739124;7079.04432901562;7084.291570842977;7088.787336379917;7135.82160445993;7145.392286735443;5736.885262294731;5770.422957704196;5805.419458054161;5870.3249126350165;6003.279606447167;1546.760252160917;1585.2153184173908;1635.8118816336037;1639.7376419773018;1688.0799964019639;958.9856152157723;965.1072757699101;1005.7370915440259;1048.6539441984128;1105.4969988655143;16843.326266949185;17470.388536401166;17545.473635790946;17598.824011759974;17707.911460442614;911.7857303533664;941.2304866850278;968.7384406210284;979.9706008819746;1059.8940105989338;9936.155426788659;10181.879993200742;10186.286959912883;10200.38797672142;10238.948805255926;378106;387577;392253;534153;542448;68744;70827;72117;72738.63630681812;73633.6318318405;1096.446294621227;1136.8578927634046;1137.624583887315;1140.355699030062;1148.9310641361378;15520.22398880029;15526.767098493758;15764.842351576337;15900.680434522787;16014.759778603096;34938;34943.82528087343;35299.82350088233;35934.460983085795;36499.45250821186;46194.76902615465;48004;48489.75755121202;49438.50561494483;49610.75194624004;9310.975792662937;9337.71986840396;9485.810283794424;9531.094546018117;9551;11580.30518168879;11652.94173529127;11735.823962640738;11748.823767643322;12892;11294.830577541179;12699.682507937376;14008.369623367176;14129.858701412853;14192.36134373935;12734.554290599785;13211;13483.865161348262;13636.113652612548;14195.077319974169;11299.71750706206;11619.883801161881;11756.647300580997;14120.223387713775;14459.566213013626;8630.5253211074;8688.26149777276;8744.519051451976;8819.647214111621;8837.513936733285;13206.207627542379;13608.183508989492;13632.250226237653;13654.590362289147;14134.858651413355 05:56:21 INFO - 2015-12-21 05:56:21,516 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1554.3627112883719;1659.9502014939553;1726.1455579488147;1748.3618479255076;1763.418072036228;6737.730490780369;7649.617519124043;7829.060512738472;7867.881981770278;7877.172896845835;7702.268284512977;7906.644201010954;7907.406944479173;7909.406794490422;7911.92088079119;1946.240966023252;1987.5229944813213;2235.0724449353497;2309.642005489152;2350.1421980976907;2260.604394231011;2263.841531092824;2265.0600000999566;2266.172846910874;2266.8526545774553;2248.3592176229777;2346.4837735698206;2349.9765002350014;2352.764723527642;2354.364321633158;2246.70792796937;2256.8194544436487;2257.3679369776487;2258.8192944564394;2259.8418110732255;2229.320057382498;2241.069955968271;2318.258157389636;2341.8126549876138;2342.636891281854;7666.156722760492;7668.846623067563;7728.729494467723;7749.961250193713;7801.375889928792;4670;4731.834385796481;4778.832740854088;4789.3294938708605;4791.9520804791855;3215.565898603682;3266.379387916288;3278.459054256045;3285.244393789442;3286.112749557606;938.915497605212;950.8098380323894;983.7540614846289;1024.938503689781;1037.1339931157493;10957.12343012557;10985.560577576887;11019.504122314514;11023.338599683964;11027.724306892393;4281.464816897887;4375.956240437618;4378.0806030733265;4405.823767049346;4419.535948725402;9340.159385655188;9341.112594303666;9347.719568412958;9354.204892584206;9354.438733676001;4739.526047395233;4743.928841067387;4752.809887604526;4775.952240477551;4783.1390349737385;4244.72409293395;4326.502452218036;4327.848525301662;4331.545187755303;4333.653307735373;3166.3508980658908;3197.1847178969215;3413.2832105257676;3443.7589368744448;3689.2437050405138;1221.2184202110657;1234.6110975042832;1251.6557946564767;1256.39065053449;1257.1953949472345;1006.2352612014921;1009.5860697114148;1083.6153165626247;1173.4778023779336;1380.9861901380857;7471.4396420268695;7549.5847728374365;7555.622218889033;7632.923670763333;7635.274648908456;1119.5633702855894;1128.2158899564888;1146.6502716671496;1147.0708725932022;1151.424287856072;5901.675407852609;5960.523158147338;5998.790042348584;6003.6998150093195;6010.3088144863905;9521.047895210562;9636.951815240878;9640.855387169198;9765.560549775277;9767.218622510181;9423.811523769486;9502.239820814319;9510.28672849539;9634.373765705206;9645.228381729445;7333.926660733325;7466.253374662599;7536.321731044122;7543.321101100927;7543.547387156788;6979.825504362431;7037.542559733601;7053.329933656294;7054.188768291507;7134.821629459305;8321.16788321163;8378.371622128243;8482.915170848213;8608.698695545876;8609.87085193735;8408;8736.91263087361;8751.824963500821;8921.330900182382;8934.061923497939;7175.712971481291;7271.018412514243;7272.709091636275;7278.781636550912;7279.818004549928;6605.405513503808;6794.796156115324;7258.782236532912;7442.330190282901;7456.328930396074;6914;7148.034290569927;7273.199948005609;7292.380147687506;7315.451341149542;7106.822329441805;7124.073870396815;7183;7221.169565499825;7287.562746235243;7092.148942126978;7165.140183178052;7185.784426467214;7194.964025179841;7205.7838264852135;6564.245111812012;6566.080748695282;6597.043428702716;6604.8348791280605;6606.471482281502;6614.173228346457;6683.699233534599;6725.630090344882;6726.159230096238;6726.562773419712 05:56:21 INFO - 2015-12-21 05:56:21,519 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.5375051802735;342.99657003429974;344.6760045557176;351.63254399152885;352.05824419677356;5783.6529808211535;5841.123831425289;5881.323647780507;5906.320773111093;5937.317208521022;5733.312002559688;5826.912596311048;5882.970585147079;5888.617239879405;5903.2325797646245;4599.218132917412;4605.3092036194585;4606.355110284546;4608.953910460886;4612.123696497655;4419.38128661986;4482.731036137826;4549.11292298002;4568;4605.815767369301;4505.189065968125;4519.435070616173;4520.344550040242;4521.864344069683;4540.160070386989;4500.234960056766;4520.141173177086;4525.683202175833;4533.320001999694;4597.908041839178;4058.8376464941366;4059.5534491205945;4062.2687916175078;4065.0447144920918;4065.4511640928686;5542.362628297717;5666.971665141689;5699.914501282484;5713.314402271754;5728.026235539968;5279.656822306538;5281.9207711884355;5288.762005709714;5288.92066619001;5296.3379577552805;6019.8194054178;6302.149209856657;6303.653299068549;6307.8738425231695;6315.147455093549;4313.547077556843;4319.660905119423;4398.274284743014;4402.361657559668;4410.867673969786;6435.259945106326;6528.706208220594;6539.738410463576;6540.901886471706;6542.771003014919;4487.932681009787;4494.483134439516;4494.595486406174;4499;4501.48232953208;4471.217536931089;4543.863684089482;4557.293619488984;4562.110388474216;4568.840090596813;5188.11801993662;5242.266082748418;5249.055170069424;5250.579953603703;5259.65812222212;6295.276043255084;6309.2428908530355;6312.210973628296;6317.46301564363;6317.6209427434505;1574.6929348776878;1582.841715828408;1586.0483709774273;1586.0721477935306;1586.9761953570705;1052.2003277509148;1056.7410984308895;1062.1661995333625;1083.9078678312433;1083.9403832789271;6047.63714177142;6048.153258543807;6058.303295121117;6058.727357268934;6060.818175454655;6491.772787952399;6492.513061520405;6497.122888410098;6500.609963402117;6511.446527045254;5919.970400147971;6038.18484504595;6046.486048685911;6053.697315134225;6057.666828324396;3503.649635036476;3521.964780352164;3528.2943411317838;3530.2762933599065;3533.5759708835103;6542.574732642363;6545.574537655132;6550.148480697479;6552.836179095465;6554.082428460019;6655.933440665628;6665.266820649725;6670.299618540081;6670.533062685566;6672.132622759107;6416.711247993851;6558.868822623521;6564.4420224281475;6570.474362051024;6582.17722784652;6256.562040657111;6464.482841372773;6466.127072845105;6466.159399278064;6467.353264673495;6301.369863013662;6451.096846441408;6488.805335839932;6505;6508.544401892012;6646;6649.501287403561;6653.933460665331;6659.966700166468;6663.100481434944;4379.189849877783;4515;4520.819167233274;4523.90952180948;4528.298113792367;6492.740290388331;6497.480201583957;6505.154329937078;6511.73953041873;6517.576357536745;6344.968275158594;6355.396237357444;6355.936440635534;6358.745650173942;6369.585976911486;6221.2845522763655;6309.337519560564;6340.080688300079;6346.587471814318;6347.492200624031;6212.06818977157;6216.098665693539;6220.03589443637;6220.129181914626;6227.1282020516255;6358.1734374531015;6358.968205158944;6359.49124070064;6360.93639063622;6372.139761132188;6036.758529658764;6153;6163.260408750979;6169.537284703575;6172.506199504119 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: |5;yui.html;862.4825104937037;867.4838471109691;868.535333596526;869.5304535550803;869.8695195720641;13167.736645267089;13550.864491355083;13593.660158496043;13596.524121655744;13608.591742247749;12460.563880264193;12631.621051368473;12673.746525069493;12681.112322137455;12693.238405695665;672.2302963107239;682.6620822692774;806.9273765361116;811.0996793559144;823.9958800205991;822.0915887943826;824.3158178711685;827.730987429085;828.159418190537;829.4194064155085;864.5547543015321;869.2394155114275;871.0331531999476;871.1419252036738;871.8822958900531;698.7589281697832;710.0414440505328;847.3856454070811;863.4042510667682;866.5537248317122;643.5816719132555;645.1677336236249;645.8288553533271;646.169671971519;646.5861848417017;12633.747325053539;12912.935435322763;12987.480500779957;13062.085654004224;13084.411201495956;11512.59705910289;12443.813342799865;12727;12749.808752868714;13027.544035958696;9558.474283914382;9616.663416780379;9702.854457183148;9798.951005244999;10221.233407494468;3666.5233519642543;3684.355237833395;3687.483752274684;3730.1607138393915;3732.7573707709184;44579.77710111494;44601.107977840584;44854;44890.775546122386;44912;8478.152184781473;8938.374313798102;8952;9333.439993600407;9602.807943841224;17666.734998975026;17667.646647066987;17676;17689.823101769074;17694.646107077788;7187.9281207188305;7396.96301518489;7553.357964573072;7595.240475952471;7687;4279.229738647011;4293.957060429419;4307.956920430818;4315.654747620183;4456.353828694886;3143.6384815746023;3150.905472835773;3180.8727650894166;3189.091109033914;3191.9680803191673;552.8479668091227;573.435166361134;574.1129954220739;574.184657785945;581.7324030945728;498.464151037636;543.6411968101035;620.6183197333607;638.9520785941073;724.3951300663899;8468;8562.914370856337;8577.228049475578;8707.216975748282;9028.458292502472;571.6770024935898;635.7298148286959;655.5673255651247;675.1459403854128;685.2051620120636;3743.9625603744157;3844.9038774030314;3880.670143037817;4003.959960400417;4091.7749523775883;54501;54949.725251374286;55630.443695563335;55636.72181639066;55678.44321556733;48451.515484845404;48491;48797.75601121972;48832.511674883506;49125;43413.782931085145;43720.344194837104;44481;45405.318920216225;45923.31115033344;8209.958950205211;8296.46073005277;8813.735587932373;8918.955405222932;8929.955350223207;34344.65655343414;34464.483032754026;35004.82497587496;36141.27717445689;38543.42184867173;43631.345529817714;44275.33586996133;45085.32372014488;45430.545694542634;45479.54520454753;10654.414007229676;10864.239503234698;10928.847352024923;11021.669349919515;11368.317900925971;11913.880861191277;11949.581764638197;11985.940070299594;12499.812502812283;12518.749625007267;11423.371714555778;11565.884341156818;11738;11760.23558468731;12156.939215303866;11033.944830276118;11155.27490713101;11353.432328383713;11553.24903881245;12263.816042759187;10939.726506837393;10969.945150274198;11471.483783229607;11588.304701717923;11668.124890633067;9676.516174191403;9740.318177727491;9881;9982.550785214538;10132.645357412455;9499.620015199314;9502.287328450255;9665.033496650278;9745.561449734638;9764.462954537285 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: __startTimestamp1450706181506__endTimestamp 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5275.53 Median:5441.81 stddev:578.38 (10.6%) stddev-sans-first:555.12 05:56:21 INFO - 2015-12-21 05:56:21,520 DEBUG : BROWSER_OUTPUT: Values: 3130.2 3151.1 3206.5 3211.0 3237.2 5144.1 5261.1 5285.1 5325.2 5380.2 5210.9 5237.2 5248.5 5336.2 5451.1 4801.8 4812.2 4835.6 4877.2 4971.8 4710.4 4954.4 4978.0 4995.2 5034.5 4743.5 4762.4 4796.5 4806.2 4813.4 4858.7 4862.1 4864.5 4870.4 4886.9 4698.4 4827.1 4836.9 4854.8 4911.4 5081.6 5125.3 5149.8 5168.6 5206.7 5652.0 5660.7 5666.3 5669.3 5707.9 5530.3 5644.1 5699.9 5715.1 5718.1 4911.6 5312.8 5318.5 5352.1 5379.4 5853.6 5926.1 5927.6 5933.6 5938.2 5356.8 5456.0 5653.5 5687.3 5700.5 5591.6 5606.4 5654.3 5664.0 5713.2 5639.5 5652.2 5684.0 5684.6 5688.4 5450.2 5548.7 5676.4 5677.3 5688.3 4366.0 4373.3 4426.1 4448.4 4462.3 3857.9 3865.6 3876.4 3912.8 3916.8 5150.8 5250.8 5300.4 5314.9 5356.4 5642.2 5703.4 5721.0 5747.5 5778.9 5402.0 5431.7 5438.6 5444.9 5454.5 4856.5 4959.8 5048.5 5062.1 5112.8 5713.7 5738.7 5846.1 5861.5 5901.4 5669.9 5670.8 5673.0 5675.6 5680.8 5579.4 5703.9 5737.7 5762.1 5776.4 5596.7 5651.4 5715.3 5718.5 5773.1 5777.5 5800.4 5809.6 5813.2 5813.7 5441.8 5535.8 5661.8 5667.9 5677.0 5488.5 5551.9 5567.5 5570.7 5588.4 5423.9 5427.2 5429.3 5431.0 5461.9 5463.7 5508.1 5513.3 5606.4 5622.8 5309.2 5359.8 5361.4 5363.3 5384.9 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42715.97 Median:32357.50 stddev:68412.53 (211.4%) stddev-sans-first:68531.22 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: Values: 558.1 575.5 597.2 610.2 611.2 30522.7 31030.1 31032.4 37503.0 38103.8 41814.8 42346.8 42374.0 42468.4 42471.7 8679.2 8834.0 8836.2 8837.0 8845.3 7677.5 7830.4 10245.1 10627.3 10641.8 10248.6 10343.0 10407.6 10416.1 10426.1 7603.2 7730.4 10262.5 10370.8 10373.2 10339.4 10557.9 10581.0 10612.5 10616.2 39385.2 39985.0 40031.4 40072.4 40126.4 3032.9 3227.5 3767.6 3777.8 3881.7 29534.4 30136.5 30171.5 30203.3 30253.5 3889.2 3945.7 3974.8 4015.9 4042.4 266814.0 267607.0 268030.0 268463.0 269669.0 52255.3 52860.0 58621.4 59576.1 59619.7 59847.4 59886.7 60099.0 60107.4 60109.7 13425.9 13446.5 13457.2 13522.9 13531.1 9787.7 9842.6 9879.1 9920.5 9984.3 19394.9 19609.6 19647.6 19726.7 19746.4 7214.2 7361.4 7425.7 7436.8 7436.9 920.9 988.3 1024.9 1049.3 1057.5 28296.3 28919.0 29215.3 29269.3 31241.8 960.4 979.3 997.6 1010.8 1018.1 13715.5 13901.8 14081.3 14099.9 14125.3 307136.0 309359.0 309522.0 309720.0 310563.0 51510.2 51660.0 51703.0 51787.2 51854.2 1332.7 1343.4 1351.6 1351.8 1359.2 25395.7 25925.7 26587.5 26996.2 27069.9 42914.0 43322.4 43359.0 43370.6 43493.8 195156.0 195494.0 196441.0 196698.0 197153.0 27609.6 27981.0 31004.7 31723.2 32192.5 37429.6 37812.6 37964.6 38268.6 38280.8 32421.0 32490.5 32911.9 33082.0 35641.1 30652.7 31381.5 33858.5 35532.3 36935.8 33220.0 33270.8 33561.5 35787.3 36147.1 28776.4 31495.2 32294.0 32453.5 32480.7 24594.4 25305.9 25625.4 26682.9 26820.6 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25985.34 Median:346.17 stddev:74162.47 (21423.9%) stddev-sans-first:74345.52 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: Values: 341.5 345.3 346.1 346.2 346.6 14163.9 14463.9 16102.7 16602.7 18142.9 16131.5 16263.5 16816.0 17214.1 17229.1 5317.4 5437.6 5438.5 5442.0 5444.3 3940.6 4006.1 5385.7 5827.0 6031.0 5929.3 5957.6 5958.7 5975.7 5979.2 5807.0 5933.4 5965.1 5974.6 5987.0 5155.9 5220.7 5224.2 5257.1 5273.8 20492.0 20526.4 20630.8 21193.9 21253.4 2003.4 2040.3 2135.8 2167.1 2587.1 12945.2 13041.9 13146.5 13235.1 13483.0 1831.7 1838.2 1841.8 1869.7 1911.1 58419.0 62313.4 62449.1 62456.0 62733.0 9158.9 9229.6 9376.3 9397.2 9424.2 12046.0 12066.7 12091.3 12094.7 12108.9 7220.3 7233.8 7296.1 7321.6 7391.9 7079.0 7084.3 7088.8 7135.8 7145.4 5736.9 5770.4 5805.4 5870.3 6003.3 1546.8 1585.2 1635.8 1639.7 1688.1 959.0 965.1 1005.7 1048.7 1105.5 16843.3 17470.4 17545.5 17598.8 17707.9 911.8 941.2 968.7 980.0 1059.9 9936.2 10181.9 10186.3 10200.4 10238.9 378106.0 387577.0 392253.0 534153.0 542448.0 68744.0 70827.0 72117.0 72738.6 73633.6 1096.4 1136.9 1137.6 1140.4 1148.9 15520.2 15526.8 15764.8 15900.7 16014.8 34938.0 34943.8 35299.8 35934.5 36499.5 46194.8 48004.0 48489.8 49438.5 49610.8 9311.0 9337.7 9485.8 9531.1 9551.0 11580.3 11652.9 11735.8 11748.8 12892.0 11294.8 12699.7 14008.4 14129.9 14192.4 12734.6 13211.0 13483.9 13636.1 14195.1 11299.7 11619.9 11756.6 14120.2 14459.6 8630.5 8688.3 8744.5 8819.6 8837.5 13206.2 13608.2 13632.3 13654.6 14134.9 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5544.25 Median:6605.12 stddev:2885.33 (43.7%) stddev-sans-first:2877.84 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: Values: 1554.4 1660.0 1726.1 1748.4 1763.4 6737.7 7649.6 7829.1 7867.9 7877.2 7702.3 7906.6 7907.4 7909.4 7911.9 1946.2 1987.5 2235.1 2309.6 2350.1 2260.6 2263.8 2265.1 2266.2 2266.9 2248.4 2346.5 2350.0 2352.8 2354.4 2246.7 2256.8 2257.4 2258.8 2259.8 2229.3 2241.1 2318.3 2341.8 2342.6 7666.2 7668.8 7728.7 7750.0 7801.4 4670.0 4731.8 4778.8 4789.3 4792.0 3215.6 3266.4 3278.5 3285.2 3286.1 938.9 950.8 983.8 1024.9 1037.1 10957.1 10985.6 11019.5 11023.3 11027.7 4281.5 4376.0 4378.1 4405.8 4419.5 9340.2 9341.1 9347.7 9354.2 9354.4 4739.5 4743.9 4752.8 4776.0 4783.1 4244.7 4326.5 4327.8 4331.5 4333.7 3166.4 3197.2 3413.3 3443.8 3689.2 1221.2 1234.6 1251.7 1256.4 1257.2 1006.2 1009.6 1083.6 1173.5 1381.0 7471.4 7549.6 7555.6 7632.9 7635.3 1119.6 1128.2 1146.7 1147.1 1151.4 5901.7 5960.5 5998.8 6003.7 6010.3 9521.0 9637.0 9640.9 9765.6 9767.2 9423.8 9502.2 9510.3 9634.4 9645.2 7333.9 7466.3 7536.3 7543.3 7543.5 6979.8 7037.5 7053.3 7054.2 7134.8 8321.2 8378.4 8482.9 8608.7 8609.9 8408.0 8736.9 8751.8 8921.3 8934.1 7175.7 7271.0 7272.7 7278.8 7279.8 6605.4 6794.8 7258.8 7442.3 7456.3 6914.0 7148.0 7273.2 7292.4 7315.5 7106.8 7124.1 7183.0 7221.2 7287.6 7092.1 7165.1 7185.8 7195.0 7205.8 6564.2 6566.1 6597.0 6604.8 6606.5 6614.2 6683.7 6725.6 6726.2 6726.6 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,521 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5261.49 Median:5978.57 stddev:1570.95 (26.3%) stddev-sans-first:1531.16 05:56:21 INFO - 2015-12-21 05:56:21,522 DEBUG : BROWSER_OUTPUT: Values: 331.5 343.0 344.7 351.6 352.1 5783.7 5841.1 5881.3 5906.3 5937.3 5733.3 5826.9 5883.0 5888.6 5903.2 4599.2 4605.3 4606.4 4609.0 4612.1 4419.4 4482.7 4549.1 4568.0 4605.8 4505.2 4519.4 4520.3 4521.9 4540.2 4500.2 4520.1 4525.7 4533.3 4597.9 4058.8 4059.6 4062.3 4065.0 4065.5 5542.4 5667.0 5699.9 5713.3 5728.0 5279.7 5281.9 5288.8 5288.9 5296.3 6019.8 6302.1 6303.7 6307.9 6315.1 4313.5 4319.7 4398.3 4402.4 4410.9 6435.3 6528.7 6539.7 6540.9 6542.8 4487.9 4494.5 4494.6 4499.0 4501.5 4471.2 4543.9 4557.3 4562.1 4568.8 5188.1 5242.3 5249.1 5250.6 5259.7 6295.3 6309.2 6312.2 6317.5 6317.6 1574.7 1582.8 1586.0 1586.1 1587.0 1052.2 1056.7 1062.2 1083.9 1083.9 6047.6 6048.2 6058.3 6058.7 6060.8 6491.8 6492.5 6497.1 6500.6 6511.4 5920.0 6038.2 6046.5 6053.7 6057.7 3503.6 3522.0 3528.3 3530.3 3533.6 6542.6 6545.6 6550.1 6552.8 6554.1 6655.9 6665.3 6670.3 6670.5 6672.1 6416.7 6558.9 6564.4 6570.5 6582.2 6256.6 6464.5 6466.1 6466.2 6467.4 6301.4 6451.1 6488.8 6505.0 6508.5 6646.0 6649.5 6653.9 6660.0 6663.1 4379.2 4515.0 4520.8 4523.9 4528.3 6492.7 6497.5 6505.2 6511.7 6517.6 6345.0 6355.4 6355.9 6358.7 6369.6 6221.3 6309.3 6340.1 6346.6 6347.5 6212.1 6216.1 6220.0 6220.1 6227.1 6358.2 6359.0 6359.5 6360.9 6372.1 6036.8 6153.0 6163.3 6169.5 6172.5 05:56:21 INFO - 2015-12-21 05:56:21,523 DEBUG : BROWSER_OUTPUT: 05:56:21 INFO - 2015-12-21 05:56:21,523 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13489.19 Median:45701.43 stddev:15353.14 (33.6%) stddev-sans-first:15366.93 05:56:21 INFO - 2015-12-21 05:56:21,523 DEBUG : BROWSER_OUTPUT: Values: 862.5 867.5 868.5 869.5 869.9 13167.7 13550.9 13593.7 13596.5 13608.6 12460.6 12631.6 12673.7 12681.1 12693.2 672.2 682.7 806.9 811.1 824.0 822.1 824.3 827.7 828.2 829.4 864.6 869.2 871.0 871.1 871.9 698.8 710.0 847.4 863.4 866.6 643.6 645.2 645.8 646.2 646.6 12633.7 12912.9 12987.5 13062.1 13084.4 11512.6 12443.8 12727.0 12749.8 13027.5 9558.5 9616.7 9702.9 9799.0 10221.2 3666.5 3684.4 3687.5 3730.2 3732.8 44579.8 44601.1 44854.0 44890.8 44912.0 8478.2 8938.4 8952.0 9333.4 9602.8 17666.7 17667.6 17676.0 17689.8 17694.6 7187.9 7397.0 7553.4 7595.2 7687.0 4279.2 4294.0 4308.0 4315.7 4456.4 3143.6 3150.9 3180.9 3189.1 3192.0 552.8 573.4 574.1 574.2 581.7 498.5 543.6 620.6 639.0 724.4 8468.0 8562.9 8577.2 8707.2 9028.5 571.7 635.7 655.6 675.1 685.2 3744.0 3844.9 3880.7 4004.0 4091.8 54501.0 54949.7 55630.4 55636.7 55678.4 48451.5 48491.0 48797.8 48832.5 49125.0 43413.8 43720.3 44481.0 45405.3 45923.3 8210.0 8296.5 8813.7 8919.0 8930.0 34344.7 34464.5 35004.8 36141.3 38543.4 43631.3 44275.3 45085.3 45430.5 45479.5 10654.4 10864.2 10928.8 11021.7 11368.3 11913.9 11949.6 11985.9 12499.8 12518.7 11423.4 11565.9 11738.0 11760.2 12156.9 11033.9 11155.3 11353.4 11553.2 12263.8 10939.7 10969.9 11471.5 11588.3 11668.1 9676.5 9740.3 9881.0 9982.6 10132.6 9499.6 9502.3 9665.0 9745.6 9764.5 05:56:21 INFO - 2015-12-21 05:56:21,523 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:21 INFO - 2015-12-21 05:56:21,523 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-12-21 05:56:22,226 INFO : Browser exited with error code: 0 05:56:22 INFO - 2015-12-21 05:56:22,244 INFO : Completed test dromaeo_css (00:18:32) 05:56:22 INFO - 2015-12-21 05:56:22,245 INFO : Starting test kraken 05:56:22 INFO - 2015-12-21 05:56:22,245 DEBUG : operating with platform_type : linux_ 05:56:22 INFO - 2015-12-21 05:56:22,245 INFO : Initialising browser for kraken test... 05:56:22 INFO - 2015-12-21 05:56:22,251 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEXYdTV/profile http://localhost:46359/getInfo.html 05:56:26 INFO - 2015-12-21 05:56:26,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:56:26 INFO - 2015-12-21 05:56:26,091 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:56:26 INFO - 2015-12-21 05:56:26,091 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:56:26 INFO - 2015-12-21 05:56:26,091 DEBUG : BROWSER_OUTPUT: __metrics 05:56:26 INFO - 2015-12-21 05:56:26,155 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:56:26 INFO - 2015-12-21 05:56:26,211 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:27 INFO - 2015-12-21 05:56:27,123 INFO : Browser initialized. 05:56:27 INFO - 2015-12-21 05:56:27,123 INFO : Running cycle 1/1 for kraken test... 05:56:27 INFO - 2015-12-21 05:56:27,123 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEXYdTV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:38 INFO - 2015-12-21 05:56:38,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 150151168 05:56:38 INFO - 2015-12-21 05:56:38,903 DEBUG : BROWSER_OUTPUT: 05:56:41 INFO - 2015-12-21 05:56:41,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46359/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:41 INFO - 2015-12-21 05:56:41,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 186388480 05:56:41 INFO - 2015-12-21 05:56:41,925 DEBUG : BROWSER_OUTPUT: 05:56:44 INFO - 2015-12-21 05:56:44,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46359/tests/kraken/driver.html?testName=audio-dft) 05:56:45 INFO - 2015-12-21 05:56:45,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 176689152 05:56:45 INFO - 2015-12-21 05:56:45,108 DEBUG : BROWSER_OUTPUT: 05:56:47 INFO - 2015-12-21 05:56:47,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46359/tests/kraken/driver.html?testName=audio-fft) 05:56:48 INFO - 2015-12-21 05:56:48,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 160931840 05:56:48 INFO - 2015-12-21 05:56:48,520 DEBUG : BROWSER_OUTPUT: 05:56:50 INFO - 2015-12-21 05:56:50,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46359/tests/kraken/driver.html?testName=audio-oscillator) 05:56:51 INFO - 2015-12-21 05:56:51,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 163368960 05:56:51 INFO - 2015-12-21 05:56:51,078 DEBUG : BROWSER_OUTPUT: 05:56:53 INFO - 2015-12-21 05:56:53,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:53 INFO - 2015-12-21 05:56:53,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 164720640 05:56:53 INFO - 2015-12-21 05:56:53,817 DEBUG : BROWSER_OUTPUT: 05:56:56 INFO - 2015-12-21 05:56:56,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46359/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:57 INFO - 2015-12-21 05:56:57,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 165871616 05:56:57 INFO - 2015-12-21 05:56:57,286 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-12-21 05:57:00,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46359/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:01 INFO - 2015-12-21 05:57:01,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 166031360 05:57:01 INFO - 2015-12-21 05:57:01,225 DEBUG : BROWSER_OUTPUT: 05:57:04 INFO - 2015-12-21 05:57:04,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46359/tests/kraken/driver.html?testName=json-parse-financial) 05:57:04 INFO - 2015-12-21 05:57:04,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 165187584 05:57:04 INFO - 2015-12-21 05:57:04,605 DEBUG : BROWSER_OUTPUT: 05:57:06 INFO - 2015-12-21 05:57:06,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:06 INFO - 2015-12-21 05:57:06,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 176386048 05:57:06 INFO - 2015-12-21 05:57:06,726 DEBUG : BROWSER_OUTPUT: 05:57:08 INFO - 2015-12-21 05:57:08,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:09 INFO - 2015-12-21 05:57:09,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 175697920 05:57:09 INFO - 2015-12-21 05:57:09,159 DEBUG : BROWSER_OUTPUT: 05:57:11 INFO - 2015-12-21 05:57:11,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:11 INFO - 2015-12-21 05:57:11,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 186593280 05:57:11 INFO - 2015-12-21 05:57:11,785 DEBUG : BROWSER_OUTPUT: 05:57:14 INFO - 2015-12-21 05:57:14,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:14 INFO - 2015-12-21 05:57:14,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 192950272 05:57:14 INFO - 2015-12-21 05:57:14,785 DEBUG : BROWSER_OUTPUT: 05:57:17 INFO - 2015-12-21 05:57:17,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:17 INFO - 2015-12-21 05:57:17,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 191393792 05:57:17 INFO - 2015-12-21 05:57:17,953 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46359/tests/kraken/driver.html?testName=ai-astar) 05:57:19 INFO - 2015-12-21 05:57:19,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 248995840 05:57:19 INFO - 2015-12-21 05:57:19,891 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,891 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:57:19 INFO - 2015-12-21 05:57:19,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;104;111;112;109;98;109;109;116 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;124;146;161;125;157;148;131;167;129 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;160;160;163;159;162;161;160 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;81;96;72;72;72;105;90;72 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;138;93;94;94;139;93;94;138 05:57:19 INFO - 2015-12-21 05:57:19,892 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;110;110;109 05:57:19 INFO - 2015-12-21 05:57:19,893 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;146;145;147;145;151;145;145;145 05:57:19 INFO - 2015-12-21 05:57:19,893 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;96;95;95;96;95;96 05:57:19 INFO - 2015-12-21 05:57:19,893 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;56;58;58;58;71;55;56 05:57:19 INFO - 2015-12-21 05:57:19,893 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;67;68;76;67;71;67 05:57:19 INFO - 2015-12-21 05:57:19,893 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;84;84;84;84;85;87;84;86 05:57:19 INFO - 2015-12-21 05:57:19,893 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;114;115;126;118;126;124;123;134;116 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;144;156;155;154;144;155;157;158;143 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;70;69;69;67;69;67;67;66;68 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: __startTimestamp1450706239890__endTimestamp 05:57:19 INFO - 2015-12-21 05:57:19,894 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:4.84 (4.4%) stddev-sans-first:5.10 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 104.0 111.0 112.0 109.0 98.0 109.0 109.0 116.0 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,902 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.50 stddev:15.79 (10.5%) stddev-sans-first:16.41 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: Values: 153.0 124.0 146.0 161.0 125.0 157.0 148.0 131.0 167.0 129.0 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 160.0 160.0 163.0 159.0 162.0 161.0 160.0 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:72.00 stddev:12.56 (17.4%) stddev-sans-first:12.88 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 81.0 96.0 72.0 72.0 72.0 105.0 90.0 72.0 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:94.00 stddev:21.49 (22.9%) stddev-sans-first:22.26 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 138.0 93.0 94.0 94.0 139.0 93.0 94.0 138.0 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,903 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:145.50 stddev:1.91 (1.3%) stddev-sans-first:2.00 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 146.0 145.0 147.0 145.0 151.0 145.0 145.0 145.0 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.50 stddev:4.48 (7.7%) stddev-sans-first:4.76 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 56.0 58.0 58.0 58.0 71.0 55.0 56.0 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:2.78 (4.1%) stddev-sans-first:2.93 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 67.0 68.0 76.0 67.0 71.0 67.0 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:1.18 (1.4%) stddev-sans-first:1.12 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 84.0 84.0 84.0 84.0 85.0 87.0 84.0 86.0 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:125.00 stddev:6.50 (5.2%) stddev-sans-first:6.57 05:57:19 INFO - 2015-12-21 05:57:19,904 DEBUG : BROWSER_OUTPUT: Values: 128.0 114.0 115.0 126.0 118.0 126.0 124.0 123.0 134.0 116.0 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:155.00 stddev:6.77 (4.4%) stddev-sans-first:6.20 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: Values: 141.0 144.0 156.0 155.0 154.0 144.0 155.0 157.0 158.0 143.0 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.40 (2.0%) stddev-sans-first:1.32 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: Values: 66.0 70.0 69.0 69.0 67.0 69.0 67.0 67.0 66.0 68.0 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:57:19 INFO - 2015-12-21 05:57:19,905 DEBUG : BROWSER_OUTPUT: 05:57:20 INFO - 2015-12-21 05:57:20,762 INFO : Browser exited with error code: 0 05:57:20 INFO - 2015-12-21 05:57:20,812 INFO : Completed test kraken (00:00:58) 05:57:20 INFO - 2015-12-21 05:57:20,812 INFO : Starting test v8_7 05:57:20 INFO - 2015-12-21 05:57:20,812 DEBUG : operating with platform_type : linux_ 05:57:20 INFO - 2015-12-21 05:57:20,812 INFO : Initialising browser for v8_7 test... 05:57:20 INFO - 2015-12-21 05:57:20,819 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYW4hYs/profile http://localhost:46359/getInfo.html 05:57:24 INFO - 2015-12-21 05:57:24,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:57:24 INFO - 2015-12-21 05:57:24,662 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:57:24 INFO - 2015-12-21 05:57:24,662 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:57:24 INFO - 2015-12-21 05:57:24,662 DEBUG : BROWSER_OUTPUT: __metrics 05:57:24 INFO - 2015-12-21 05:57:24,743 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:57:24 INFO - 2015-12-21 05:57:24,798 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:24 ERROR - 2015-12-21 05:57:24,814 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:57:25 INFO - 2015-12-21 05:57:25,589 INFO : Browser initialized. 05:57:25 INFO - 2015-12-21 05:57:25,590 INFO : Running cycle 1/1 for v8_7 test... 05:57:25 INFO - 2015-12-21 05:57:25,590 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYW4hYs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:57:37 INFO - 2015-12-21 05:57:37,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 150253568 05:57:37 INFO - 2015-12-21 05:57:37,371 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46359/tests/v8_7/run.html (next: http://localhost:46359/tests/v8_7/run.html) 05:57:58 INFO - 2015-12-21 05:57:58,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 568008704 05:57:58 INFO - 2015-12-21 05:57:58,965 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,966 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:57:58 INFO - 2015-12-21 05:57:58,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:57:58 INFO - 2015-12-21 05:57:58,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:57:58 INFO - 2015-12-21 05:57:58,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:57:58 INFO - 2015-12-21 05:57:58,966 DEBUG : BROWSER_OUTPUT: |0;Richards;166.19577862722286 05:57:58 INFO - 2015-12-21 05:57:58,966 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.67924528301887 05:57:58 INFO - 2015-12-21 05:57:58,967 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 05:57:58 INFO - 2015-12-21 05:57:58,967 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 05:57:58 INFO - 2015-12-21 05:57:58,967 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1962.7450980392157 05:57:58 INFO - 2015-12-21 05:57:58,967 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 05:57:58 INFO - 2015-12-21 05:57:58,967 DEBUG : BROWSER_OUTPUT: |6;Boyer;12071.42857142857 05:57:58 INFO - 2015-12-21 05:57:58,967 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 05:57:58 INFO - 2015-12-21 05:57:58,968 DEBUG : BROWSER_OUTPUT: |8;Splay;646.4124111182934 05:57:58 INFO - 2015-12-21 05:57:58,968 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:57:58 INFO - 2015-12-21 05:57:58,968 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:57:58 INFO - 2015-12-21 05:57:58,968 DEBUG : BROWSER_OUTPUT: __startTimestamp1450706278962__endTimestamp 05:57:58 INFO - 2015-12-21 05:57:58,968 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,968 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: Values: 166.2 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,969 DEBUG : BROWSER_OUTPUT: Values: 188.7 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: Values: 280.0 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: Values: 5138.5 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: Values: 1962.7 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: Values: 784.9 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12071.43 Median:12071.43 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: Values: 12071.4 05:57:58 INFO - 2015-12-21 05:57:58,970 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: Values: 26342.1 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:646.41 Median:646.41 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: Values: 646.4 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:57:58 INFO - 2015-12-21 05:57:58,971 DEBUG : BROWSER_OUTPUT: 05:57:59 INFO - 2015-12-21 05:57:59,834 INFO : Browser exited with error code: 0 05:57:59 INFO - 2015-12-21 05:57:59,850 INFO : Completed test v8_7 (00:00:39) 05:58:00 INFO - 2015-12-21 05:58:00,025 INFO : Completed test suite (00:20:10) 05:58:00 INFO - 2015-12-21 05:58:00,025 DEBUG : Working with test: dromaeo_css 05:58:00 INFO - 2015-12-21 05:58:00,025 DEBUG : Generating results file: dromaeo_css 05:58:00 INFO - 2015-12-21 05:58:00,026 DEBUG : Working with test: kraken 05:58:00 INFO - 2015-12-21 05:58:00,026 DEBUG : Generating results file: kraken 05:58:00 INFO - 2015-12-21 05:58:00,026 INFO : javascript benchmark 05:58:00 INFO - 2015-12-21 05:58:00,027 DEBUG : Working with test: v8_7 05:58:00 INFO - 2015-12-21 05:58:00,027 DEBUG : Generating results file: v8_7 05:58:00 INFO - 2015-12-21 05:58:00,027 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:00 INFO - 2015-12-21 05:58:00,075 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:58:00 INFO - 2015-12-21 05:58:00,075 DEBUG : process_Request line: dromaeo_css 6939.82 graph.html#tests=[[72,201,35]] 05:58:00 INFO - 2015-12-21 05:58:00,075 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:00 INFO - 2015-12-21 05:58:00,103 DEBUG : process_Request line: kraken 1504.40 graph.html#tests=[[232,201,35]] 05:58:00 INFO - 2015-12-21 05:58:00,103 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:00 INFO - 2015-12-21 05:58:00,136 DEBUG : process_Request line: v8_7 19747.76 graph.html#tests=[[230,201,35]] 05:58:00 INFO - 2015-12-21 05:58:00,137 INFO : javascript benchmark 05:58:00 INFO - 2015-12-21 05:58:00,141 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.2017985413718, 3151.1019359482525, 3206.519022146678, 3211.020638705194, 3237.239248776537, 5144.0740666679985, 5261.1319132343215, 5285.101532739434, 5325.20121981703, 5380.246765452835, 5210.921836172451, 5237.188235823444, 5248.47515248475, 5336.199570064492, 5451.073317536018, 4801.759912004403, 4812.23004319309, 4835.588974937117, 4877.219644856824, 4971.751412429382, 4710.387649605546, 4954.380702412199, 4977.950220497803, 4995.150824359867, 5034.496550344973, 4743.549362810528, 4762.4046994125565, 4796.472388037313, 4806.158922188638, 4813.374261346003, 4858.659893807435, 4862.124817532843, 4864.464908860023, 4870.391201099863, 4886.877828054292, 4698.38920940279, 4827.131116399047, 4836.927446088312, 4854.757262136879, 4911.435184953741, 5081.568066714333, 5125.282460455539, 5149.76826042829, 5168.5606723428555, 5206.713630750307, 5652.0, 5660.66036037835, 5666.291713535808, 5669.319681638189, 5707.857303567444, 5530.2810634617645, 5644.068728659766, 5699.886002279973, 5715.142728590703, 5718.113692377647, 4911.582515486188, 5312.814051508179, 5318.547923426513, 5352.063388907003, 5379.408265090837, 5853.590248682552, 5926.051831706906, 5927.555433342516, 5933.643981361132, 5938.198343223609, 5356.812511562077, 5456.0, 5653.491185793298, 5687.260656114679, 5700.486956173964, 5591.552675786009, 5606.439356064361, 5654.264945557051, 5664.037113690682, 5713.200151978726, 5639.464250896158, 5652.208690783294, 5683.976884160891, 5684.573656975744, 5688.431156884361, 5450.182472629137, 5548.69482178484, 5676.432356764373, 5677.347105082886, 5688.260526131659, 4366.0, 4373.343998400265, 4426.070525189682, 4448.421705178371, 4462.308342206963, 3857.9421308680394, 3865.594112618191, 3876.3604005338802, 3912.8043597820565, 3916.7649941003633, 5150.793968241303, 5250.842474725764, 5300.44345343741, 5314.867128321823, 5356.3572371315695, 5642.210090587321, 5703.372629010805, 5720.971395143081, 5747.453991870766, 5778.88442231153, 5401.972990135024, 5431.728413579305, 5438.564914806806, 5444.945550544523, 5454.509094181542, 4856.538628830255, 4959.752012399365, 5048.545630893237, 5062.088824011639, 5112.769925353368, 5713.657180569179, 5738.655680659173, 5846.0646296593195, 5861.501772349313, 5901.3508514063415, 5669.858253543694, 5670.829875103754, 5672.971635141798, 5675.574331925205, 5680.829575112753, 5579.442055794388, 5703.857403564944, 5737.684427356536, 5762.1068734346245, 5776.393478684678, 5596.664200148004, 5651.4348565143155, 5715.31416230055, 5718.51392631631, 5773.1051686988585, 5777.537796976316, 5800.361960184461, 5809.622374545641, 5813.244278243801, 5813.738381772746, 5441.809536666197, 5535.806246781343, 5661.830145095653, 5667.886642267049, 5677.034904066401, 5488.506034456918, 5551.8889622208135, 5567.498925096761, 5570.693611851387, 5588.441155884379, 5423.945760542344, 5427.185922111715, 5429.321334833146, 5430.972845135749, 5461.9180712290145, 5463.672179669074, 5508.11870100798, 5513.338399392099, 5606.355269144101, 5622.7750889963945, 5309.203619457112, 5359.839204823861, 5361.437049109787, 5363.329583802025, 5384.946150538444], "unit": "score", "name": "dojo.html", "value": 5238.629390705425}, {"lowerIsBetter": false, "replicates": [558.1209594888053, 575.5136909311631, 597.169933792029, 610.2280615021995, 611.1871211288985, 30522.694773052262, 31030.06909792707, 31032.37935241294, 37503.0, 38103.80948095256, 41814.79092604533, 42346.788266058706, 42374.0, 42468.362974555406, 42471.72584822452, 8679.17547832955, 8833.95583022084, 8836.248918841906, 8836.955815220916, 8845.336599755012, 7677.500962437423, 7830.373570114377, 10245.129164021067, 10627.256092073558, 10641.840372394421, 10248.641297554586, 10342.965703429672, 10407.635732749355, 10416.114630256438, 10426.061654451098, 7603.163651998276, 7730.381569474484, 10262.460630905349, 10370.844437333446, 10373.222008349367, 10339.431331276777, 10557.9472102639, 10581.0, 10612.469376531142, 10616.150707943347, 39385.21229575421, 39985.0, 40031.39952900709, 40072.39891401602, 40126.39810402846, 3032.863521141554, 3227.5320078588707, 3767.571509925954, 3777.7544459610035, 3881.6506514413836, 29534.409311813644, 30136.54795178074, 30171.547426788617, 30203.31848563476, 30253.546196807067, 3889.2221555688975, 3945.6646185074305, 3974.7813870237123, 4015.9397609035886, 4042.3734321180264, 266814.0, 267607.0, 268030.0, 268463.0, 269669.0, 52255.25192228852, 52860.0, 58621.413785861594, 59576.10635840466, 59619.70190149022, 59847.40152598506, 59886.70056649689, 60099.0, 60107.398926011054, 60109.69945150246, 13425.865741342657, 13446.529371471952, 13457.192568445924, 13522.864771352357, 13531.120477168952, 9787.706368808947, 9842.557084931195, 9879.11088002069, 9920.4543750093, 9984.301098923152, 19394.92706531616, 19609.607807843764, 19647.60704785925, 19726.70409943852, 19746.40760777179, 7214.206437291894, 7361.447891408166, 7425.740099096506, 7436.814079648052, 7436.925630743732, 920.9447433154032, 988.2588058955783, 1024.9231307651955, 1049.302214027663, 1057.5135437698746, 28296.292592684935, 28919.0, 29215.269618259288, 29269.268268293035, 31241.843790780902, 960.356561104048, 979.299800642544, 997.5660587644398, 1010.7877345757327, 1018.149844879519, 13715.451381944611, 13901.79147312791, 14081.2959352032, 14099.929500352433, 14125.293735313193, 307136.0, 309359.0, 309522.0, 309720.0, 310563.0, 51510.22734658983, 51660.0, 51703.0, 51787.223191652156, 51854.22218666723, 1332.6801567623895, 1343.4156142078227, 1351.594521643503, 1351.7904724767677, 1359.2252416122715, 25395.74604254008, 25925.740742592334, 26587.468250635266, 26996.1901142966, 27069.86465067662, 42914.0, 43322.350164746924, 43359.0, 43370.566294337914, 43493.78253108714, 195156.0, 195494.0, 196441.0, 196698.0, 197153.0, 27609.585856212576, 27981.0, 31004.68995310018, 31723.20691982719, 32192.517112242866, 37429.62570374261, 37812.62187378091, 37964.62035379611, 38268.61731382651, 38280.80859595684, 32421.0, 32490.51264230991, 32911.886014248215, 33082.0, 35641.1089722759, 30652.693473064985, 31381.529277060406, 33858.49212261867, 35532.289354212255, 36935.815320923226, 33220.0, 33270.83364583162, 33561.49657755184, 35787.28425431425, 36147.0963225911, 28776.424471510873, 31495.212619683774, 32294.0, 32453.51319730159, 32480.675193247764, 24594.38514037092, 25305.87347063253, 25625.359366016, 26682.866585666947, 26820.59769103426], "unit": "score", "name": "ext.html", "value": 17981.77996743369}, {"lowerIsBetter": false, "replicates": [341.53380635432626, 345.2731999141806, 346.1294843468677, 346.2054584728049, 346.61179478983536, 14163.929180354084, 14463.92768036161, 16102.67794644108, 16602.667946641075, 18142.90928545357, 16131.516054518353, 16263.51209463715, 16816.0, 17214.13929303533, 17229.05240211788, 5317.41508434072, 5437.592180586452, 5438.456154384549, 5442.047641662713, 5444.292242008553, 3940.6059394060508, 4006.1386801837743, 5385.67685938843, 5827.0, 6030.969845150768, 5929.318128415244, 5957.553183511232, 5958.702064896759, 5975.671338076404, 5979.222701048858, 5807.0, 5933.436323549256, 5965.105234214859, 5974.581779275452, 5987.0420732683, 5155.9484405155845, 5220.660657057279, 5224.164133738584, 5257.106291930381, 5273.762680679379, 20492.0, 20526.38420847377, 20630.793692063187, 21193.894030529904, 21253.36239912805, 2003.3589251439546, 2040.3062958594148, 2135.7757435469207, 2167.0789914286524, 2587.0815860369676, 12945.158564693358, 13041.934790326082, 13146.539871104465, 13235.139715918434, 13482.988775841852, 1831.716084006981, 1838.218757028271, 1841.815818418161, 1869.7475840761458, 1911.0826803134573, 58418.973513397934, 62313.376866231214, 62449.06326405153, 62456.0, 62733.0, 9158.86261706075, 9229.584668689926, 9376.296777741696, 9397.201237894718, 9424.198943089777, 12046.0, 12066.69833254158, 12091.334976576196, 12094.730053344272, 12108.939455302843, 7220.3140701633265, 7233.782986510413, 7296.124465064227, 7321.597312147883, 7391.926080739124, 7079.04432901562, 7084.291570842977, 7088.787336379917, 7135.82160445993, 7145.392286735443, 5736.885262294731, 5770.422957704196, 5805.419458054161, 5870.3249126350165, 6003.279606447167, 1546.760252160917, 1585.2153184173908, 1635.8118816336037, 1639.7376419773018, 1688.0799964019639, 958.9856152157723, 965.1072757699101, 1005.7370915440259, 1048.6539441984128, 1105.4969988655143, 16843.326266949185, 17470.388536401166, 17545.473635790946, 17598.824011759974, 17707.911460442614, 911.7857303533664, 941.2304866850278, 968.7384406210284, 979.9706008819746, 1059.8940105989338, 9936.155426788659, 10181.879993200742, 10186.286959912883, 10200.38797672142, 10238.948805255926, 378106.0, 387577.0, 392253.0, 534153.0, 542448.0, 68744.0, 70827.0, 72117.0, 72738.63630681812, 73633.6318318405, 1096.446294621227, 1136.8578927634046, 1137.624583887315, 1140.355699030062, 1148.9310641361378, 15520.22398880029, 15526.767098493758, 15764.842351576337, 15900.680434522787, 16014.759778603096, 34938.0, 34943.82528087343, 35299.82350088233, 35934.460983085795, 36499.45250821186, 46194.76902615465, 48004.0, 48489.75755121202, 49438.50561494483, 49610.75194624004, 9310.975792662937, 9337.71986840396, 9485.810283794424, 9531.094546018117, 9551.0, 11580.30518168879, 11652.94173529127, 11735.823962640738, 11748.823767643322, 12892.0, 11294.830577541179, 12699.682507937376, 14008.369623367176, 14129.858701412853, 14192.36134373935, 12734.554290599785, 13211.0, 13483.865161348262, 13636.113652612548, 14195.077319974169, 11299.71750706206, 11619.883801161881, 11756.647300580997, 14120.223387713775, 14459.566213013626, 8630.5253211074, 8688.26149777276, 8744.519051451976, 8819.647214111621, 8837.513936733285, 13206.207627542379, 13608.183508989492, 13632.250226237653, 13654.590362289147, 14134.858651413355], "unit": "score", "name": "jquery.html", "value": 8778.134484735716}, {"lowerIsBetter": false, "replicates": [1554.3627112883719, 1659.9502014939553, 1726.1455579488147, 1748.3618479255076, 1763.418072036228, 6737.730490780369, 7649.617519124043, 7829.060512738472, 7867.881981770278, 7877.172896845835, 7702.268284512977, 7906.644201010954, 7907.406944479173, 7909.406794490422, 7911.92088079119, 1946.240966023252, 1987.5229944813213, 2235.0724449353497, 2309.642005489152, 2350.1421980976907, 2260.604394231011, 2263.841531092824, 2265.0600000999566, 2266.172846910874, 2266.8526545774553, 2248.3592176229777, 2346.4837735698206, 2349.9765002350014, 2352.764723527642, 2354.364321633158, 2246.70792796937, 2256.8194544436487, 2257.3679369776487, 2258.8192944564394, 2259.8418110732255, 2229.320057382498, 2241.069955968271, 2318.258157389636, 2341.8126549876138, 2342.636891281854, 7666.156722760492, 7668.846623067563, 7728.729494467723, 7749.961250193713, 7801.375889928792, 4670.0, 4731.834385796481, 4778.832740854088, 4789.3294938708605, 4791.9520804791855, 3215.565898603682, 3266.379387916288, 3278.459054256045, 3285.244393789442, 3286.112749557606, 938.915497605212, 950.8098380323894, 983.7540614846289, 1024.938503689781, 1037.1339931157493, 10957.12343012557, 10985.560577576887, 11019.504122314514, 11023.338599683964, 11027.724306892393, 4281.464816897887, 4375.956240437618, 4378.0806030733265, 4405.823767049346, 4419.535948725402, 9340.159385655188, 9341.112594303666, 9347.719568412958, 9354.204892584206, 9354.438733676001, 4739.526047395233, 4743.928841067387, 4752.809887604526, 4775.952240477551, 4783.1390349737385, 4244.72409293395, 4326.502452218036, 4327.848525301662, 4331.545187755303, 4333.653307735373, 3166.3508980658908, 3197.1847178969215, 3413.2832105257676, 3443.7589368744448, 3689.2437050405138, 1221.2184202110657, 1234.6110975042832, 1251.6557946564767, 1256.39065053449, 1257.1953949472345, 1006.2352612014921, 1009.5860697114148, 1083.6153165626247, 1173.4778023779336, 1380.9861901380857, 7471.4396420268695, 7549.5847728374365, 7555.622218889033, 7632.923670763333, 7635.274648908456, 1119.5633702855894, 1128.2158899564888, 1146.6502716671496, 1147.0708725932022, 1151.424287856072, 5901.675407852609, 5960.523158147338, 5998.790042348584, 6003.6998150093195, 6010.3088144863905, 9521.047895210562, 9636.951815240878, 9640.855387169198, 9765.560549775277, 9767.218622510181, 9423.811523769486, 9502.239820814319, 9510.28672849539, 9634.373765705206, 9645.228381729445, 7333.926660733325, 7466.253374662599, 7536.321731044122, 7543.321101100927, 7543.547387156788, 6979.825504362431, 7037.542559733601, 7053.329933656294, 7054.188768291507, 7134.821629459305, 8321.16788321163, 8378.371622128243, 8482.915170848213, 8608.698695545876, 8609.87085193735, 8408.0, 8736.91263087361, 8751.824963500821, 8921.330900182382, 8934.061923497939, 7175.712971481291, 7271.018412514243, 7272.709091636275, 7278.781636550912, 7279.818004549928, 6605.405513503808, 6794.796156115324, 7258.782236532912, 7442.330190282901, 7456.328930396074, 6914.0, 7148.034290569927, 7273.199948005609, 7292.380147687506, 7315.451341149542, 7106.822329441805, 7124.073870396815, 7183.0, 7221.169565499825, 7287.562746235243, 7092.148942126978, 7165.140183178052, 7185.784426467214, 7194.964025179841, 7205.7838264852135, 6564.245111812012, 6566.080748695282, 6597.043428702716, 6604.8348791280605, 6606.471482281502, 6614.173228346457, 6683.699233534599, 6725.630090344882, 6726.159230096238, 6726.562773419712], "unit": "score", "name": "mootools.html", "value": 4549.981282252204}, {"lowerIsBetter": false, "replicates": [331.5375051802735, 342.99657003429974, 344.6760045557176, 351.63254399152885, 352.05824419677356, 5783.6529808211535, 5841.123831425289, 5881.323647780507, 5906.320773111093, 5937.317208521022, 5733.312002559688, 5826.912596311048, 5882.970585147079, 5888.617239879405, 5903.2325797646245, 4599.218132917412, 4605.3092036194585, 4606.355110284546, 4608.953910460886, 4612.123696497655, 4419.38128661986, 4482.731036137826, 4549.11292298002, 4568.0, 4605.815767369301, 4505.189065968125, 4519.435070616173, 4520.344550040242, 4521.864344069683, 4540.160070386989, 4500.234960056766, 4520.141173177086, 4525.683202175833, 4533.320001999694, 4597.908041839178, 4058.8376464941366, 4059.5534491205945, 4062.2687916175078, 4065.0447144920918, 4065.4511640928686, 5542.362628297717, 5666.971665141689, 5699.914501282484, 5713.314402271754, 5728.026235539968, 5279.656822306538, 5281.9207711884355, 5288.762005709714, 5288.92066619001, 5296.3379577552805, 6019.8194054178, 6302.149209856657, 6303.653299068549, 6307.8738425231695, 6315.147455093549, 4313.547077556843, 4319.660905119423, 4398.274284743014, 4402.361657559668, 4410.867673969786, 6435.259945106326, 6528.706208220594, 6539.738410463576, 6540.901886471706, 6542.771003014919, 4487.932681009787, 4494.483134439516, 4494.595486406174, 4499.0, 4501.48232953208, 4471.217536931089, 4543.863684089482, 4557.293619488984, 4562.110388474216, 4568.840090596813, 5188.11801993662, 5242.266082748418, 5249.055170069424, 5250.579953603703, 5259.65812222212, 6295.276043255084, 6309.2428908530355, 6312.210973628296, 6317.46301564363, 6317.6209427434505, 1574.6929348776878, 1582.841715828408, 1586.0483709774273, 1586.0721477935306, 1586.9761953570705, 1052.2003277509148, 1056.7410984308895, 1062.1661995333625, 1083.9078678312433, 1083.9403832789271, 6047.63714177142, 6048.153258543807, 6058.303295121117, 6058.727357268934, 6060.818175454655, 6491.772787952399, 6492.513061520405, 6497.122888410098, 6500.609963402117, 6511.446527045254, 5919.970400147971, 6038.18484504595, 6046.486048685911, 6053.697315134225, 6057.666828324396, 3503.649635036476, 3521.964780352164, 3528.2943411317838, 3530.2762933599065, 3533.5759708835103, 6542.574732642363, 6545.574537655132, 6550.148480697479, 6552.836179095465, 6554.082428460019, 6655.933440665628, 6665.266820649725, 6670.299618540081, 6670.533062685566, 6672.132622759107, 6416.711247993851, 6558.868822623521, 6564.4420224281475, 6570.474362051024, 6582.17722784652, 6256.562040657111, 6464.482841372773, 6466.127072845105, 6466.159399278064, 6467.353264673495, 6301.369863013662, 6451.096846441408, 6488.805335839932, 6505.0, 6508.544401892012, 6646.0, 6649.501287403561, 6653.933460665331, 6659.966700166468, 6663.100481434944, 4379.189849877783, 4515.0, 4520.819167233274, 4523.90952180948, 4528.298113792367, 6492.740290388331, 6497.480201583957, 6505.154329937078, 6511.73953041873, 6517.576357536745, 6344.968275158594, 6355.396237357444, 6355.936440635534, 6358.745650173942, 6369.585976911486, 6221.2845522763655, 6309.337519560564, 6340.080688300079, 6346.587471814318, 6347.492200624031, 6212.06818977157, 6216.098665693539, 6220.03589443637, 6220.129181914626, 6227.1282020516255, 6358.1734374531015, 6358.968205158944, 6359.49124070064, 6360.93639063622, 6372.139761132188, 6036.758529658764, 6153.0, 6163.260408750979, 6169.537284703575, 6172.506199504119], "unit": "score", "name": "prototype.html", "value": 4752.938656306374}, {"lowerIsBetter": false, "replicates": [862.4825104937037, 867.4838471109691, 868.535333596526, 869.5304535550803, 869.8695195720641, 13167.736645267089, 13550.864491355083, 13593.660158496043, 13596.524121655744, 13608.591742247749, 12460.563880264193, 12631.621051368473, 12673.746525069493, 12681.112322137455, 12693.238405695665, 672.2302963107239, 682.6620822692774, 806.9273765361116, 811.0996793559144, 823.9958800205991, 822.0915887943826, 824.3158178711685, 827.730987429085, 828.159418190537, 829.4194064155085, 864.5547543015321, 869.2394155114275, 871.0331531999476, 871.1419252036738, 871.8822958900531, 698.7589281697832, 710.0414440505328, 847.3856454070811, 863.4042510667682, 866.5537248317122, 643.5816719132555, 645.1677336236249, 645.8288553533271, 646.169671971519, 646.5861848417017, 12633.747325053539, 12912.935435322763, 12987.480500779957, 13062.085654004224, 13084.411201495956, 11512.59705910289, 12443.813342799865, 12727.0, 12749.808752868714, 13027.544035958696, 9558.474283914382, 9616.663416780379, 9702.854457183148, 9798.951005244999, 10221.233407494468, 3666.5233519642543, 3684.355237833395, 3687.483752274684, 3730.1607138393915, 3732.7573707709184, 44579.77710111494, 44601.107977840584, 44854.0, 44890.775546122386, 44912.0, 8478.152184781473, 8938.374313798102, 8952.0, 9333.439993600407, 9602.807943841224, 17666.734998975026, 17667.646647066987, 17676.0, 17689.823101769074, 17694.646107077788, 7187.9281207188305, 7396.96301518489, 7553.357964573072, 7595.240475952471, 7687.0, 4279.229738647011, 4293.957060429419, 4307.956920430818, 4315.654747620183, 4456.353828694886, 3143.6384815746023, 3150.905472835773, 3180.8727650894166, 3189.091109033914, 3191.9680803191673, 552.8479668091227, 573.435166361134, 574.1129954220739, 574.184657785945, 581.7324030945728, 498.464151037636, 543.6411968101035, 620.6183197333607, 638.9520785941073, 724.3951300663899, 8468.0, 8562.914370856337, 8577.228049475578, 8707.216975748282, 9028.458292502472, 571.6770024935898, 635.7298148286959, 655.5673255651247, 675.1459403854128, 685.2051620120636, 3743.9625603744157, 3844.9038774030314, 3880.670143037817, 4003.959960400417, 4091.7749523775883, 54501.0, 54949.725251374286, 55630.443695563335, 55636.72181639066, 55678.44321556733, 48451.515484845404, 48491.0, 48797.75601121972, 48832.511674883506, 49125.0, 43413.782931085145, 43720.344194837104, 44481.0, 45405.318920216225, 45923.31115033344, 8209.958950205211, 8296.46073005277, 8813.735587932373, 8918.955405222932, 8929.955350223207, 34344.65655343414, 34464.483032754026, 35004.82497587496, 36141.27717445689, 38543.42184867173, 43631.345529817714, 44275.33586996133, 45085.32372014488, 45430.545694542634, 45479.54520454753, 10654.414007229676, 10864.239503234698, 10928.847352024923, 11021.669349919515, 11368.317900925971, 11913.880861191277, 11949.581764638197, 11985.940070299594, 12499.812502812283, 12518.749625007267, 11423.371714555778, 11565.884341156818, 11738.0, 11760.23558468731, 12156.939215303866, 11033.944830276118, 11155.27490713101, 11353.432328383713, 11553.24903881245, 12263.816042759187, 10939.726506837393, 10969.945150274198, 11471.483783229607, 11588.304701717923, 11668.124890633067, 9676.516174191403, 9740.318177727491, 9881.0, 9982.550785214538, 10132.645357412455, 9499.620015199314, 9502.287328450255, 9665.033496650278, 9745.561449734638, 9764.462954537285], "unit": "score", "name": "yui.html", "value": 6246.385532002106}], "name": "dromaeo_css", "value": 6939.823573280336}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 104.0, 111.0, 112.0, 109.0, 98.0, 109.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 146.0, 161.0, 125.0, 157.0, 148.0, 131.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 163.0, 159.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 81.0, 96.0, 72.0, 72.0, 72.0, 105.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 93.0, 94.0, 94.0, 139.0, 93.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 147.0, 145.0, 151.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 56.0, 58.0, 58.0, 58.0, 71.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 76.0, 67.0, 71.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 87.0, 84.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [128.0, 114.0, 115.0, 126.0, 118.0, 126.0, 124.0, 123.0, 134.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 156.0, 155.0, 154.0, 144.0, 155.0, 157.0, 158.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 69.0, 69.0, 67.0, 69.0, 67.0, 67.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1504.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12071.42857142857], "unit": "score", "name": "Boyer", "value": 55.209952662721896}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [646.4124111182934], "unit": "score", "name": "Splay", "value": 126.06657699999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19747.75779415673}]} 05:58:00 INFO - RETURN: dromaeo_css: 6939.82 05:58:00 INFO - RETURN: kraken: 1504.40 05:58:00 INFO - RETURN: v8_7: 19747.76 05:58:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19747.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6939.82"}}} 05:58:00 INFO - Return code: 0 05:58:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:00 ERROR - # TBPL SUCCESS # 05:58:00 INFO - Running post-action listener: _resource_record_post_action 05:58:00 INFO - Running post-run listener: _resource_record_post_run 05:58:01 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 561778688; Read time: 348; Write time: 410448 05:58:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251211776; Read time: 0; Write time: 241912 05:58:01 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 24576; Write bytes: 310566912; Read time: 348; Write time: 168536 05:58:01 INFO - Running post-run listener: _upload_blobber_files 05:58:01 INFO - Blob upload gear active. 05:58:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:58:01 INFO - Copying logs to upload dir... 05:58:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.250718 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-21 05:58:01.282004) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:58:01.285772) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009988 build_url: 'https://queue.taskcluster.net/v1/task/AW4WkTIhQeCUbxyorCxxDg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:58:01.337870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:58:01.338233) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450704755.687423-1701124706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:58:01.388543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:58:01.388885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:58:01.389248) ========= ========= Total master_lag: 0.19 =========