builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1457185158.17 results: success (0) buildid: 20160305030241 builduid: 5f37f246a8ca40c0b1a90a8b27e27af0 revision: 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.167044) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.167553) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.167863) ========= 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004241 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.180301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.180583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.187562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.187844) ========= 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002186 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.233465) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.233779) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.234164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.234443) ========= 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-05 05:39:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2016-03-05 05:39:19 (100 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.373676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.373987) ========= 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009410 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.420489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.420853) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 --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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-05 05:39:19,386 truncating revision to first 12 chars 2016-03-05 05:39:19,386 Setting DEBUG logging. 2016-03-05 05:39:19,386 attempt 1/10 2016-03-05 05:39:19,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a2e0878d6c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-05 05:39:19,657 unpacking tar archive at: mozilla-central-5a2e0878d6c2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.979445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:18.979887) ========= echo 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5a2e0878d6c258b36b0ee8712a2afcde6ad94c78'] 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 program finished with exit code 0 elapsedTime=0.002363 script_repo_revision: '5a2e0878d6c258b36b0ee8712a2afcde6ad94c78' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:19.027164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:19.027465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 05:39:19.033233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-05 05:39:19.033867) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:20 INFO - MultiFileLogger online at 20160305 05:39:20 in /builds/slave/test-pgo 05:39:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:39:20 INFO - {'append_to_log': False, 05:39:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:39:20 INFO - 'blob_upload_branch': 'Firefox', 05:39:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:39:20 INFO - 'branch': 'Firefox', 05:39:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:20 INFO - 'config_files': ('talos/linux_config.py',), 05:39:20 INFO - 'default_actions': ('clobber', 05:39:20 INFO - 'read-buildbot-config', 05:39:20 INFO - 'download-and-extract', 05:39:20 INFO - 'populate-webroot', 05:39:20 INFO - 'create-virtualenv', 05:39:20 INFO - 'install', 05:39:20 INFO - 'run-tests'), 05:39:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:20 INFO - 'download_minidump_stackwalk': True, 05:39:20 INFO - 'download_symbols': 'ondemand', 05:39:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:20 INFO - 'installer_path': 'installer.exe', 05:39:20 INFO - 'log_level': 'info', 05:39:20 INFO - 'log_name': 'talos', 05:39:20 INFO - 'log_to_console': True, 05:39:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:20 INFO - 'opt_config_files': (), 05:39:20 INFO - 'pip_index': False, 05:39:20 INFO - 'sps_profile': False, 05:39:20 INFO - 'sps_profile_interval': 0, 05:39:20 INFO - 'suite': 'dromaeojs-e10s', 05:39:20 INFO - 'system_bits': '32', 05:39:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:20 INFO - 'title': 'talos-linux64-ix-048', 05:39:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:20 INFO - 'use_talos_json': True, 05:39:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:39:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:20 INFO - 'work_dir': 'build'} 05:39:20 INFO - ##### 05:39:20 INFO - ##### Running clobber step. 05:39:20 INFO - ##### 05:39:20 INFO - Running pre-action listener: _resource_record_pre_action 05:39:20 INFO - Running main action method: clobber 05:39:20 INFO - rmtree: /builds/slave/test-pgo/build 05:39:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:39:21 INFO - Running post-action listener: _resource_record_post_action 05:39:21 INFO - ##### 05:39:21 INFO - ##### Running read-buildbot-config step. 05:39:21 INFO - ##### 05:39:21 INFO - Running pre-action listener: _resource_record_pre_action 05:39:21 INFO - Running main action method: read_buildbot_config 05:39:21 INFO - Using buildbot properties: 05:39:21 INFO - { 05:39:21 INFO - "project": "", 05:39:21 INFO - "product": "firefox", 05:39:21 INFO - "script_repo_revision": "production", 05:39:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:39:21 INFO - "repository": "", 05:39:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:39:21 INFO - "buildid": "20160305030241", 05:39:21 INFO - "stage_platform": "linux64-pgo", 05:39:21 INFO - "basedir": "/builds/slave/test-pgo", 05:39:21 INFO - "nightly_build": "True", 05:39:21 INFO - "buildnumber": 657, 05:39:21 INFO - "slavename": "talos-linux64-ix-048", 05:39:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:39:21 INFO - "platform": "ubuntu64_hw", 05:39:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:21 INFO - "branch": "mozilla-central", 05:39:21 INFO - "repo_path": "mozilla-central", 05:39:21 INFO - "revision": "5a2e0878d6c258b36b0ee8712a2afcde6ad94c78", 05:39:21 INFO - "pgo_build": "True", 05:39:21 INFO - "builduid": "5f37f246a8ca40c0b1a90a8b27e27af0", 05:39:21 INFO - "slavebuilddir": "test" 05:39:21 INFO - } 05:39:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:39:21 INFO - Running post-action listener: _resource_record_post_action 05:39:21 INFO - ##### 05:39:21 INFO - ##### Running download-and-extract step. 05:39:21 INFO - ##### 05:39:21 INFO - Running pre-action listener: _resource_record_pre_action 05:39:21 INFO - Running main action method: download_and_extract 05:39:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:39:21 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:39:21 INFO - https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:39:24 INFO - Downloaded 1448 bytes. 05:39:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:24 INFO - Using the following test package requirements: 05:39:24 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'jsshell-linux-x86_64.zip'], 05:39:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:24 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:24 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:39:24 INFO - https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:39:25 INFO - Downloaded 23396813 bytes. 05:39:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:26 INFO - Return code: 0 05:39:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:39: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:39:26 INFO - https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:39:35 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip: [Errno 104] Connection reset by peer 05:39:35 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 05:39:35 INFO - retry: Failed, sleeping 30 seconds before retrying 05:40:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:40:06 INFO - Downloaded 23396813 bytes. 05:40:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:40:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:40:08 INFO - Return code: 0 05:40:08 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:40:08 INFO - https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:40:09 INFO - Downloaded 10803659 bytes. 05:40:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:40:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:40:09 INFO - Return code: 0 05:40:09 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:40:09 INFO - https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:40:10 INFO - Downloaded 56124173 bytes. 05:40:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:40:10 INFO - mkdir: /builds/slave/test-pgo/properties 05:40:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:40:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:40:10 INFO - Contents: 05:40:10 INFO - build_url:https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:40:11 INFO - Running post-action listener: _resource_record_post_action 05:40:11 INFO - Running post-action listener: set_extra_try_arguments 05:40:11 INFO - ##### 05:40:11 INFO - ##### Running populate-webroot step. 05:40:11 INFO - ##### 05:40:11 INFO - Running pre-action listener: _resource_record_pre_action 05:40:11 INFO - Running main action method: populate_webroot 05:40:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:11 INFO - '--tppagecycles', 05:40:11 INFO - '7'], 05:40:11 INFO - 'tests': ['tsvgm']}}, 05:40:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:40:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:40:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'tests': ['damp', 'tps']}, 05:40:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['damp', 'tps']}, 05:40:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:40:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:11 INFO - 'other': {'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other_l64': {'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other_nol64': {'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'svgr': {'tests': ['tsvgx', 05:40:11 INFO - 'tsvgr_opacity', 05:40:11 INFO - 'tart', 05:40:11 INFO - 'tscrollx', 05:40:11 INFO - 'cart']}, 05:40:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tsvgx', 05:40:11 INFO - 'tsvgr_opacity', 05:40:11 INFO - 'tart', 05:40:11 INFO - 'tscrollx', 05:40:11 INFO - 'cart']}, 05:40:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'tests': ['tp5o']}, 05:40:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tp5o']}, 05:40:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--xperf_path', 05:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:11 INFO - 'tests': ['tp5n']}, 05:40:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s', 05:40:11 INFO - '--xperf_path', 05:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:11 INFO - 'tests': ['tp5n']}}, 05:40:11 INFO - 'talos.zip': {'path': '', 05:40:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:11 INFO - Running post-action listener: _resource_record_post_action 05:40:11 INFO - ##### 05:40:11 INFO - ##### Running create-virtualenv step. 05:40:11 INFO - ##### 05:40:11 INFO - Running pre-action listener: _resource_record_pre_action 05:40:11 INFO - Running main action method: create_virtualenv 05:40:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:40:11 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:40:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:40:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:11 INFO - Using real prefix '/usr' 05:40:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:40:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:13 INFO - Installing pip.................done. 05:40:13 INFO - Return code: 0 05:40:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:40:13 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:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:13 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:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:40:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:40:13 INFO - Using env: {'DISPLAY': ':0', 05:40:13 INFO - 'HOME': '/home/cltbld', 05:40:13 INFO - 'LANG': 'en_US.UTF-8', 05:40:13 INFO - 'LANGUAGE': 'en_US:en', 05:40:13 INFO - 'LOGNAME': 'cltbld', 05:40:13 INFO - 'MAIL': '/var/mail/cltbld', 05:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:13 INFO - 'MOZ_NO_REMOTE': '1', 05:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:13 INFO - 'NO_EM_RESTART': '1', 05:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:13 INFO - 'SHELL': '/bin/bash', 05:40:13 INFO - 'SHLVL': '1', 05:40:13 INFO - 'TERM': 'linux', 05:40:13 INFO - 'TMOUT': '86400', 05:40:13 INFO - 'USER': 'cltbld', 05:40:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:13 INFO - '_': '/tools/buildbot/bin/python'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 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:40:14 INFO - Cleaning up... 05:40:14 INFO - Return code: 0 05:40:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:40: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:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:40:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:40:14 INFO - Using env: {'DISPLAY': ':0', 05:40:14 INFO - 'HOME': '/home/cltbld', 05:40:14 INFO - 'LANG': 'en_US.UTF-8', 05:40:14 INFO - 'LANGUAGE': 'en_US:en', 05:40:14 INFO - 'LOGNAME': 'cltbld', 05:40:14 INFO - 'MAIL': '/var/mail/cltbld', 05:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:14 INFO - 'MOZ_NO_REMOTE': '1', 05:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:14 INFO - 'NO_EM_RESTART': '1', 05:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:14 INFO - 'SHELL': '/bin/bash', 05:40:14 INFO - 'SHLVL': '1', 05:40:14 INFO - 'TERM': 'linux', 05:40:14 INFO - 'TMOUT': '86400', 05:40:14 INFO - 'USER': 'cltbld', 05:40:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:14 INFO - '_': '/tools/buildbot/bin/python'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 INFO - Downloading/unpacking psutil>=0.7.1 05:40: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:40: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:40: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:40: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:40: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:40: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:40:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:16 INFO - Installing collected packages: psutil 05:40:16 INFO - Running setup.py install for psutil 05:40:16 INFO - building 'psutil._psutil_linux' extension 05:40:16 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:40:16 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:40:16 INFO - building 'psutil._psutil_posix' extension 05:40:16 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:40:16 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:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:16 INFO - Successfully installed psutil 05:40:16 INFO - Cleaning up... 05:40:16 INFO - Return code: 0 05:40:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:40: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:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:40:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:40:16 INFO - Using env: {'DISPLAY': ':0', 05:40:16 INFO - 'HOME': '/home/cltbld', 05:40:16 INFO - 'LANG': 'en_US.UTF-8', 05:40:16 INFO - 'LANGUAGE': 'en_US:en', 05:40:16 INFO - 'LOGNAME': 'cltbld', 05:40:16 INFO - 'MAIL': '/var/mail/cltbld', 05:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:16 INFO - 'MOZ_NO_REMOTE': '1', 05:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:16 INFO - 'NO_EM_RESTART': '1', 05:40:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:16 INFO - 'SHELL': '/bin/bash', 05:40:16 INFO - 'SHLVL': '1', 05:40:16 INFO - 'TERM': 'linux', 05:40:16 INFO - 'TMOUT': '86400', 05:40:16 INFO - 'USER': 'cltbld', 05:40:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:16 INFO - '_': '/tools/buildbot/bin/python'} 05:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:40: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:40: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:40: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:40: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:40: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:40: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:40:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:40:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:18 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:40:18 INFO - Installing collected packages: mozsystemmonitor 05:40:18 INFO - Running setup.py install for mozsystemmonitor 05:40:18 INFO - Successfully installed mozsystemmonitor 05:40:18 INFO - Cleaning up... 05:40:18 INFO - Return code: 0 05:40:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:40:18 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:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:18 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:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:40:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:40:18 INFO - Using env: {'DISPLAY': ':0', 05:40:18 INFO - 'HOME': '/home/cltbld', 05:40:18 INFO - 'LANG': 'en_US.UTF-8', 05:40:18 INFO - 'LANGUAGE': 'en_US:en', 05:40:18 INFO - 'LOGNAME': 'cltbld', 05:40:18 INFO - 'MAIL': '/var/mail/cltbld', 05:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:18 INFO - 'MOZ_NO_REMOTE': '1', 05:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:18 INFO - 'NO_EM_RESTART': '1', 05:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:18 INFO - 'SHELL': '/bin/bash', 05:40:18 INFO - 'SHLVL': '1', 05:40:18 INFO - 'TERM': 'linux', 05:40:18 INFO - 'TMOUT': '86400', 05:40:18 INFO - 'USER': 'cltbld', 05:40:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:18 INFO - '_': '/tools/buildbot/bin/python'} 05:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:40: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:40: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:40: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:40: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:40: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:40: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:40:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:20 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:40:20 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:40:20 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:40:20 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:40:20 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:40:20 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:40:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:40:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:21 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:40:21 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:40:21 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:40:21 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:40:21 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:40:21 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:40:21 INFO - Downloading docopt-0.6.1.tar.gz 05:40:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:21 INFO - Running setup.py install for blobuploader 05:40:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:40:21 INFO - Running setup.py install for requests 05:40:21 INFO - Running setup.py install for docopt 05:40:22 INFO - Successfully installed blobuploader requests docopt 05:40:22 INFO - Cleaning up... 05:40:22 INFO - Return code: 0 05:40:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:22 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:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:22 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:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:40:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:22 INFO - Using env: {'DISPLAY': ':0', 05:40:22 INFO - 'HOME': '/home/cltbld', 05:40:22 INFO - 'LANG': 'en_US.UTF-8', 05:40:22 INFO - 'LANGUAGE': 'en_US:en', 05:40:22 INFO - 'LOGNAME': 'cltbld', 05:40:22 INFO - 'MAIL': '/var/mail/cltbld', 05:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:22 INFO - 'MOZ_NO_REMOTE': '1', 05:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:22 INFO - 'NO_EM_RESTART': '1', 05:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:22 INFO - 'SHELL': '/bin/bash', 05:40:22 INFO - 'SHLVL': '1', 05:40:22 INFO - 'TERM': 'linux', 05:40:22 INFO - 'TMOUT': '86400', 05:40:22 INFO - 'USER': 'cltbld', 05:40:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:22 INFO - '_': '/tools/buildbot/bin/python'} 05:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:22 INFO - Running setup.py (path:/tmp/pip-hkQX__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:22 INFO - Running setup.py (path:/tmp/pip-urEjfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:22 INFO - Running setup.py (path:/tmp/pip-HBqEti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:22 INFO - Running setup.py (path:/tmp/pip-8a1za3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:22 INFO - Running setup.py (path:/tmp/pip-Jbfiyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:22 INFO - Running setup.py (path:/tmp/pip-flRI7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:22 INFO - Running setup.py (path:/tmp/pip-8eioeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:22 INFO - Running setup.py (path:/tmp/pip-5Ce8ZP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:22 INFO - Running setup.py (path:/tmp/pip-bxDfMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:22 INFO - Running setup.py (path:/tmp/pip-MtTWvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:22 INFO - Running setup.py (path:/tmp/pip-Xu2r2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:22 INFO - Running setup.py (path:/tmp/pip-ifYvJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:23 INFO - Running setup.py (path:/tmp/pip-cdEdv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:23 INFO - Running setup.py (path:/tmp/pip-eKC7zU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:23 INFO - Running setup.py (path:/tmp/pip-PFBXgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:23 INFO - Running setup.py (path:/tmp/pip-IbvWGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:23 INFO - Running setup.py (path:/tmp/pip-5wKwfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:23 INFO - Running setup.py install for manifestparser 05:40:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:40:23 INFO - Running setup.py install for mozcrash 05:40:23 INFO - Running setup.py install for mozdebug 05:40:23 INFO - Running setup.py install for mozdevice 05:40:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:40:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:40:23 INFO - Running setup.py install for mozfile 05:40:23 INFO - Running setup.py install for mozhttpd 05:40:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:40:23 INFO - Running setup.py install for mozinfo 05:40:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:40:23 INFO - Running setup.py install for mozInstall 05:40:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozleak 05:40:24 INFO - Running setup.py install for mozlog 05:40:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for moznetwork 05:40:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozprocess 05:40:24 INFO - Running setup.py install for mozprofile 05:40:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozrunner 05:40:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozscreenshot 05:40:24 INFO - Running setup.py install for moztest 05:40:24 INFO - Running setup.py install for mozversion 05:40:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:24 INFO - Cleaning up... 05:40:24 INFO - Return code: 0 05:40:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:24 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:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:40:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:24 INFO - Using env: {'DISPLAY': ':0', 05:40:24 INFO - 'HOME': '/home/cltbld', 05:40:24 INFO - 'LANG': 'en_US.UTF-8', 05:40:24 INFO - 'LANGUAGE': 'en_US:en', 05:40:24 INFO - 'LOGNAME': 'cltbld', 05:40:24 INFO - 'MAIL': '/var/mail/cltbld', 05:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:24 INFO - 'MOZ_NO_REMOTE': '1', 05:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:24 INFO - 'NO_EM_RESTART': '1', 05:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:24 INFO - 'SHELL': '/bin/bash', 05:40:24 INFO - 'SHLVL': '1', 05:40:24 INFO - 'TERM': 'linux', 05:40:24 INFO - 'TMOUT': '86400', 05:40:24 INFO - 'USER': 'cltbld', 05:40:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:24 INFO - '_': '/tools/buildbot/bin/python'} 05:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:25 INFO - Running setup.py (path:/tmp/pip-zrXcC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:25 INFO - Running setup.py (path:/tmp/pip-85BGA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:25 INFO - Running setup.py (path:/tmp/pip-hgwAd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:25 INFO - Running setup.py (path:/tmp/pip-yYu7su-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:25 INFO - Running setup.py (path:/tmp/pip-Z76fwq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:25 INFO - Running setup.py (path:/tmp/pip-poCebf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:25 INFO - Running setup.py (path:/tmp/pip-9NaaCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:25 INFO - Running setup.py (path:/tmp/pip-Q6WOAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:25 INFO - Running setup.py (path:/tmp/pip-eZDPFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:25 INFO - Running setup.py (path:/tmp/pip-m8Dx_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:25 INFO - Running setup.py (path:/tmp/pip-4BPVtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:25 INFO - Running setup.py (path:/tmp/pip-c3M9xC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:25 INFO - Running setup.py (path:/tmp/pip-CZIFG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:25 INFO - Running setup.py (path:/tmp/pip-uKZe8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:25 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:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:25 INFO - Running setup.py (path:/tmp/pip-osgoTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:26 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:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:26 INFO - Running setup.py (path:/tmp/pip-QOhrtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:26 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:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:26 INFO - Running setup.py (path:/tmp/pip-4CARO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:26 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:40:26 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:40: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:26 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:40: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:26 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:40:26 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:40:26 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:40:26 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:40:26 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:40:26 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:40:27 INFO - Downloading blessings-1.6.tar.gz 05:40:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:28 INFO - Installing collected packages: blessings 05:40:28 INFO - Running setup.py install for blessings 05:40:28 INFO - Successfully installed blessings 05:40:28 INFO - Cleaning up... 05:40:28 INFO - Return code: 0 05:40:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:40:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:28 INFO - Reading from file tmpfile_stdout 05:40:28 INFO - Current package versions: 05:40:28 INFO - argparse == 1.2.1 05:40:28 INFO - blessings == 1.6 05:40:28 INFO - blobuploader == 1.2.4 05:40:28 INFO - docopt == 0.6.1 05:40:28 INFO - manifestparser == 1.1 05:40:28 INFO - mozInstall == 1.12 05:40:28 INFO - mozcrash == 0.16 05:40:28 INFO - mozdebug == 0.1 05:40:28 INFO - mozdevice == 0.48 05:40:28 INFO - mozfile == 1.2 05:40:28 INFO - mozhttpd == 0.7 05:40:28 INFO - mozinfo == 0.9 05:40:28 INFO - mozleak == 0.1 05:40:28 INFO - mozlog == 3.1 05:40:28 INFO - moznetwork == 0.27 05:40:28 INFO - mozprocess == 0.22 05:40:28 INFO - mozprofile == 0.28 05:40:28 INFO - mozrunner == 6.11 05:40:28 INFO - mozscreenshot == 0.1 05:40:28 INFO - mozsystemmonitor == 0.0 05:40:28 INFO - moztest == 0.7 05:40:28 INFO - mozversion == 1.4 05:40:28 INFO - psutil == 3.1.1 05:40:28 INFO - requests == 1.2.3 05:40:28 INFO - wsgiref == 0.1.2 05:40:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:28 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:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 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:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:40:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:28 INFO - Using env: {'DISPLAY': ':0', 05:40:28 INFO - 'HOME': '/home/cltbld', 05:40:28 INFO - 'LANG': 'en_US.UTF-8', 05:40:28 INFO - 'LANGUAGE': 'en_US:en', 05:40:28 INFO - 'LOGNAME': 'cltbld', 05:40:28 INFO - 'MAIL': '/var/mail/cltbld', 05:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:28 INFO - 'MOZ_NO_REMOTE': '1', 05:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:28 INFO - 'NO_EM_RESTART': '1', 05:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:28 INFO - 'SHELL': '/bin/bash', 05:40:28 INFO - 'SHLVL': '1', 05:40:28 INFO - 'TERM': 'linux', 05:40:28 INFO - 'TMOUT': '86400', 05:40:28 INFO - 'USER': 'cltbld', 05:40:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:28 INFO - '_': '/tools/buildbot/bin/python'} 05:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:40:28 INFO - Cleaning up... 05:40:28 INFO - Return code: 0 05:40:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:40:28 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:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 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:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:40:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:28 INFO - Using env: {'DISPLAY': ':0', 05:40:28 INFO - 'HOME': '/home/cltbld', 05:40:28 INFO - 'LANG': 'en_US.UTF-8', 05:40:28 INFO - 'LANGUAGE': 'en_US:en', 05:40:28 INFO - 'LOGNAME': 'cltbld', 05:40:28 INFO - 'MAIL': '/var/mail/cltbld', 05:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:28 INFO - 'MOZ_NO_REMOTE': '1', 05:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:28 INFO - 'NO_EM_RESTART': '1', 05:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:28 INFO - 'SHELL': '/bin/bash', 05:40:28 INFO - 'SHLVL': '1', 05:40:28 INFO - 'TERM': 'linux', 05:40:28 INFO - 'TMOUT': '86400', 05:40:28 INFO - 'USER': 'cltbld', 05:40:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:28 INFO - '_': '/tools/buildbot/bin/python'} 05:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:28 INFO - Downloading/unpacking jsonschema 05:40: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:40: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:40: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:40: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:40: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:40: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:40:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:30 INFO - Downloading/unpacking functools32 (from jsonschema) 05:40:30 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:40:30 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:40:30 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:40:30 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:40:30 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:40:30 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:40:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:30 INFO - warning: no files found matching '*.txt' 05:40:30 INFO - no previously-included directories found matching 'build' 05:40:30 INFO - no previously-included directories found matching 'dist' 05:40:30 INFO - no previously-included directories found matching '.git*' 05:40:30 INFO - Installing collected packages: jsonschema, functools32 05:40:30 INFO - Running setup.py install for functools32 05:40:30 INFO - warning: no files found matching '*.txt' 05:40:30 INFO - no previously-included directories found matching 'build' 05:40:30 INFO - no previously-included directories found matching 'dist' 05:40:30 INFO - no previously-included directories found matching '.git*' 05:40:30 INFO - Successfully installed jsonschema functools32 05:40:30 INFO - Cleaning up... 05:40:30 INFO - Return code: 0 05:40:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cacc02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, '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': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', '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:40:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:40:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:40:30 INFO - Using env: {'DISPLAY': ':0', 05:40:30 INFO - 'HOME': '/home/cltbld', 05:40:30 INFO - 'LANG': 'en_US.UTF-8', 05:40:30 INFO - 'LANGUAGE': 'en_US:en', 05:40:30 INFO - 'LOGNAME': 'cltbld', 05:40:30 INFO - 'MAIL': '/var/mail/cltbld', 05:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:30 INFO - 'MOZ_NO_REMOTE': '1', 05:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:30 INFO - 'NO_EM_RESTART': '1', 05:40:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:30 INFO - 'SHELL': '/bin/bash', 05:40:30 INFO - 'SHLVL': '1', 05:40:30 INFO - 'TERM': 'linux', 05:40:30 INFO - 'TMOUT': '86400', 05:40:30 INFO - 'USER': 'cltbld', 05:40:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:31 INFO - '_': '/tools/buildbot/bin/python'} 05:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:31 INFO - Downloading/unpacking flake8 05:40: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:40: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:40: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:40: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:40: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:40: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:40:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:40:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:40:32 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:40:32 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:40:32 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:40:32 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:40:32 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:40:32 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:40:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:40:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:40:33 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:40:33 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:40:33 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:40:33 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:40:33 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:40:33 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:40:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:40:33 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:40:33 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:40:33 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:40:33 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:40:33 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:40:33 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:40:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:40:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:33 INFO - no previously-included directories found matching 'docs/_build' 05:40:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:40:33 INFO - Running setup.py install for pep8 05:40:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:33 INFO - no previously-included directories found matching 'docs/_build' 05:40:33 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:40:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:40:33 INFO - Cleaning up... 05:40:33 INFO - Return code: 0 05:40:33 INFO - Running post-action listener: _resource_record_post_action 05:40:33 INFO - Running post-action listener: _start_resource_monitoring 05:40:33 INFO - Starting resource monitoring. 05:40:33 INFO - ##### 05:40:33 INFO - ##### Running install step. 05:40:33 INFO - ##### 05:40:33 INFO - Running pre-action listener: _resource_record_pre_action 05:40:33 INFO - Running main action method: install 05:40:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:34 INFO - Reading from file tmpfile_stdout 05:40:34 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:40:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:40:34 INFO - Reading from file tmpfile_stdout 05:40:34 INFO - Output received: 05:40:34 INFO - Usage: mozinstall [options] installer 05:40:34 INFO - Options: 05:40:34 INFO - -h, --help show this help message and exit 05:40:34 INFO - -d DEST, --destination=DEST 05:40:34 INFO - Directory to install application into. [default: 05:40:34 INFO - "/builds/slave/test-pgo"] 05:40:34 INFO - --app=APP Application being installed. [default: firefox] 05:40:34 INFO - mkdir: /builds/slave/test-pgo/build/application 05:40:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:40:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:40:50 INFO - Reading from file tmpfile_stdout 05:40:50 INFO - Output received: 05:40:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:40:50 INFO - Running post-action listener: _resource_record_post_action 05:40:50 INFO - ##### 05:40:50 INFO - ##### Running run-tests step. 05:40:50 INFO - ##### 05:40:50 INFO - Running pre-action listener: _resource_record_pre_action 05:40:50 INFO - Running main action method: run_tests 05:40:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:40:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:40:50 INFO - Python 2.7.3 05:40:50 INFO - Return code: 0 05:40:50 INFO - grabbing minidump binary from tooltool 05:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:50 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 0x2b76920>, '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 0x2b77820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:40:50 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:40:50 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:40:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:50 INFO - Return code: 0 05:40:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:40:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:40:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:40:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:40:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:40:51 INFO - Return code: 0 05:40:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:40:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:40:51 INFO - Using env: {'DISPLAY': ':0', 05:40:51 INFO - 'HOME': '/home/cltbld', 05:40:51 INFO - 'LANG': 'en_US.UTF-8', 05:40:51 INFO - 'LANGUAGE': 'en_US:en', 05:40:51 INFO - 'LOGNAME': 'cltbld', 05:40:51 INFO - 'MAIL': '/var/mail/cltbld', 05:40:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:51 INFO - 'MOZ_NO_REMOTE': '1', 05:40:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:51 INFO - 'NO_EM_RESTART': '1', 05:40:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:40:51 INFO - 'SHELL': '/bin/bash', 05:40:51 INFO - 'SHLVL': '1', 05:40:51 INFO - 'TERM': 'linux', 05:40:51 INFO - 'TMOUT': '86400', 05:40:51 INFO - 'USER': 'cltbld', 05:40:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900', 05:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:51 INFO - '_': '/tools/buildbot/bin/python'} 05:40:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:40:51 INFO - mozversion application_buildid: 20160305030241 05:40:51 INFO - mozversion application_changeset: 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 05:40:51 INFO - mozversion application_display_name: Nightly 05:40:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:51 INFO - mozversion application_name: Firefox 05:40:51 INFO - mozversion application_remotingname: firefox 05:40:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:51 INFO - mozversion application_vendor: Mozilla 05:40:51 INFO - mozversion application_version: 47.0a1 05:40:51 INFO - mozversion platform_buildid: 20160305030241 05:40:51 INFO - mozversion platform_changeset: 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 05:40:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:51 INFO - mozversion platform_version: 47.0a1 05:40:51 INFO - using testdate: 1457185251 05:40:51 INFO - actual date: 1457185251 05:40:51 INFO - starting webserver on 'localhost:43220' 05:40:51 INFO - SUITE-START | Running 2 tests 05:40:51 INFO - TEST-START | dromaeo_css 05:40:51 INFO - operating with platform_type : linux_ 05:40:51 INFO - Initialising browser for dromaeo_css test... 05:40:51 INFO - TEST-INFO | started process 20267 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ2ggVX/profile http://localhost:43220/getInfo.html) 05:40:55 INFO - PROCESS | 20267 | 05:40:55 INFO - PROCESS | 20267 | (process:20347): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:55 INFO - PROCESS | 20267 | __metrics Screen width/height:1600/1200 05:40:55 INFO - PROCESS | 20267 | colorDepth:24 05:40:55 INFO - PROCESS | 20267 | Browser inner width/height: 1024/697 05:40:55 INFO - PROCESS | 20267 | __metrics 05:40:56 ERROR - PROCESS | 20267 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:40:57 INFO - TEST-INFO | 20267: exit 0 05:40:57 INFO - Browser initialized. 05:40:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:57 INFO - TEST-INFO | started process 20398 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ2ggVX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:58 INFO - PROCESS | 20398 | 05:40:58 INFO - PROCESS | 20398 | (process:20459): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:41:08 INFO - PROCESS | 20398 | RSS: Main: 160686080 05:41:08 INFO - PROCESS | 20398 | 05:41:58 INFO - PROCESS | 20398 | 1457185318232 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:44:06 INFO - PROCESS | 20398 | Cycle 1(1): loaded http://localhost:43220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43220/tests/dromaeo/cssquery-ext.html) 05:44:07 INFO - PROCESS | 20398 | RSS: Main: 168693760 05:44:07 INFO - PROCESS | 20398 | 05:47:09 INFO - PROCESS | 20398 | Cycle 1(1): loaded http://localhost:43220/tests/dromaeo/cssquery-ext.html (next: http://localhost:43220/tests/dromaeo/cssquery-jquery.html) 05:47:10 INFO - PROCESS | 20398 | RSS: Main: 166330368 05:47:10 INFO - PROCESS | 20398 | 05:50:11 INFO - PROCESS | 20398 | Cycle 1(1): loaded http://localhost:43220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43220/tests/dromaeo/cssquery-mootools.html) 05:50:12 INFO - PROCESS | 20398 | RSS: Main: 166748160 05:50:12 INFO - PROCESS | 20398 | 05:53:14 INFO - PROCESS | 20398 | Cycle 1(1): loaded http://localhost:43220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43220/tests/dromaeo/cssquery-prototype.html) 05:53:14 INFO - PROCESS | 20398 | RSS: Main: 164397056 05:53:14 INFO - PROCESS | 20398 | 05:56:16 INFO - PROCESS | 20398 | Cycle 1(1): loaded http://localhost:43220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43220/tests/dromaeo/cssquery-yui.html) 05:56:17 INFO - PROCESS | 20398 | RSS: Main: 165138432 05:56:17 INFO - PROCESS | 20398 | 05:59:19 INFO - PROCESS | 20398 | Cycle 1(1): loaded http://localhost:43220/tests/dromaeo/cssquery-yui.html (next: http://localhost:43220/tests/dromaeo/cssquery-dojo.html) 05:59:20 INFO - PROCESS | 20398 | RSS: Main: 168259584 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | __start_tp_report 05:59:20 INFO - PROCESS | 20398 | _x_x_mozilla_page_load 05:59:20 INFO - PROCESS | 20398 | _x_x_mozilla_page_load_details 05:59:20 INFO - PROCESS | 20398 | |i|pagename|runs| 05:59:20 INFO - PROCESS | 20398 | |0;dojo.html;3081.0140754958416;3094.473939430295;3142.9685703142964;3156.1162874395177;3183.0928185467137;5125.308083408739;5189.351331083614;5197.064528384889;5209.817656382027;5236.528712415882;5244.711540865251;5257.369115706111;5281.075811732941;5292.2061690746405;5315.468453154683;4762.261849413329;4780.73705946172;4829.7585120744;4908.975455122737;4959.95840873417;4867.904721437683;4875.70745755254;4913.459519452857;4922.286268491067;4950.87622809429;4756.215224487973;4784.497627749089;4828.686135401188;4865.902681946377;4866.926996095061;4754.286856971482;4772.2125849234835;4794.9280760788615;4801.95198048022;4808.2547205183255;4645.605123564501;4672.462666793328;4762.880723030085;4774.904501909942;4813.638977076698;5028.874278143076;5063.468335824722;5102.846914592568;5124.871878203037;5143.717095559743;5615.5507559395555;5636.774529018834;5647.0964645656495;5653.8586535336535;5698.572607054488;5503.367112782042;5638.407967163471;5694.658320500742;5706.600537962344;5732.5987180897355;5261.789528418859;5265.236540701615;5280.735963201863;5292.311999440049;5323.467653234684;5773.220615216976;5774.278215223013;5783.1325301204315;5786.334571524244;5798.304203495523;5369.677819330853;5510.228568000483;5608.691521966331;5642.069058605366;5650.152477128464;5578.553715702734;5590.664560126405;5595.888082238333;5635.436456354331;5644.463775941279;5449.237106805051;5547.001539722808;5552.888942221133;5557.916631250535;5615.129654903497;5385.7576409061685;5509.531689806331;5517.282753242052;5572.3870374258795;5598.188262701886;4130.6282434580435;4154.231467178582;4157.97921010393;4188.036751547162;4204.600562946576;3716.6283371663158;3752.9061773455883;3755.586885442599;3757.9436308455397;3767.0394049517745;5219.1388420910125;5289.894202115936;5361.839144825662;5366.114591092504;5415.675059496442;5591.021571225019;5630.915536266959;5632.267805185382;5633.408492108351;5650.208970744099;5363.222332761806;5380.273663055437;5381;5389.757460914268;5426;4638.234691275901;4697.4832768395445;4753.191957367256;4755.548222918817;4787.257975013878;5886.440788125121;5891.086881533369;5909.527237820964;5916.792912248051;5926.525877929756;5518.061929471919;5631.465010823965;5640.661560306395;5645.774169033357;5648.604597678123;5894.911576326273;5943.435373639497;5961.701914904324;5962.97018514922;5977.3126090500145;5582.246396736388;5591.27313449249;5599.80400685974;5603.411641777555;5621.213030175861;5551.805686800943;5653.462921022497;5656.208130861765;5666.121751128417;5702.8289151325525;5390.4879036491475;5472.288602481811;5483.2323474712775;5503.284573005483;5554;5457.836264912059;5504.091824849015;5508.283923089973;5515.338159420895;5529.529989950899;5293.735313234246;5364.624476286623;5391.595630327663;5415.4313797050745;5443.510084092451;5480.205370221375;5531.834044978657;5562.527185189304;5563.248961390323;5635.492805647511;5377.059014672339;5409.323834520685;5414.891702166014;5419.403865574863;5442.455754424526 05:59:20 INFO - PROCESS | 20398 | |1;ext.html;477.43900916423195;482.8310091467987;500.4870008241552;520.0223579670219;532.936047674279;35553.82223088884;36098.097547561294;36312.455313170256;36485.81757091214;36516;39240;39861.40207896884;39865.40201896974;39890.20219595614;39933.400998984966;7907.44647874649;8666.306695464347;8676.60955257015;8683.435576687527;8706.390552661316;8625.482471051757;8740.213380795727;8743.169398907094;8778.6927457539;8816.162464565889;8754.824903501925;8841.690540831072;8856.8671469928;8862.24670902974;8885.644574217056;8713.215810577047;8783.560821958908;8800.603972821174;8805.779855503599;8829.95585022074;8643.83308253384;8816.955915220447;8852.690155844579;8857.645694172226;8905.109489051109;38202.61797382018;39402.21195576101;39618.603813962065;39628.603713963064;39896.20207595832;2896.7392934635773;3315.635280119185;3335.7498187635783;3383.1203886989315;3390.5761779777526;27117.186484405498;27561.44877102467;27607;27832.443351132864;28449.71550284512;3550.5916819565564;3566.5185199998186;3576.660217279354;3600.9562705448698;3640.1809592841664;188224;188247;188264;188377;188741;41106.58893411088;41135.58864411378;41588.168236635705;41607.75176744642;41798.791006044776;39962.60037399589;40062.79968600138;40172.799136004716;40278;40372.394414083814;14854.108753474826;15055.698886022437;15072.472463463726;15094.39622415091;15100.773488397683;11984.400779960966;12025.098117641212;12102.394880255952;12122.393880306126;12192;13958.58124256274;14006.229657368738;14008;14010.509632162826;14055.470015397326;5626.718664066781;5750.281214848144;5760.567957403127;5761.452661997104;5776.68228247442;922.3128769067088;922.7001224601897;971.0677749360551;973.2749101919115;1000.1698590170141;27294.5905811413;28199.88614706837;28236;28562.428751424854;28755.13734587966;1039.838824982129;1054.7890421915647;1085.1210519479248;1099.7910397024539;1114.4149321606221;14426.278686065654;14539.491117810825;14659.413623455155;14832.18422986746;14869.851301486846;302340;303645;307451;307631;309074;50831.745841271295;51193;51208;51503.74248128735;51605.22592161046;1294.4175121195499;1299.3762993762857;1334.6463187255579;1343.9596812095654;1344.37486568746;26362.604560931984;27727.168184954484;27783.444331113667;27835.721642784123;28147.296317592223;46299.53700463087;46332.30501542412;46500.30249546192;46731;46807.76596116998;291045;293252;294523;296392;298534;30786.69213307838;31186.532202017443;31400.68599314069;31514;31551;43440.56559434365;44231.77884110559;44283.77858110689;44290.77854610706;44547.777261113486;35292.64707352893;36325.818370907975;36448.81775591105;36846.44730329101;37167.25665486729;36495;37064.25871482609;37151.256974860895;37258;37931;31147.37705245837;35298.823505882305;35811.82094089513;36038.639613603526;36942.44586331261;29176;29906.252343691584;30016;30073.548896767003;30350.696493034786;23094.538109237386;24069.879650601633;24262.15082472105;24598;24912 05:59:20 INFO - PROCESS | 20398 | |2;jquery.html;350.8070561191344;351.6782144337931;355.2787840683412;356.1381456874364;360.80877135118396;16352.018878867277;16587.253573589187;17388.217530211125;17701.55746106348;17732.113394330296;16300.510984670478;16647.83352166478;17112;17157.399491017815;17174.141292935336;5145.948540514593;5168.147255702805;5286.4449232830575;5390.110631745757;5412.107002344628;5358.223057656637;5411.729413529328;5446.809361672343;5466.125419932811;5471.343438787351;5152.1498952672955;5350.839474815762;5391.81128660497;5421.972890135544;5423.755930983115;5308.389535203443;5316.521513063804;5335.253064570963;5341.4925582069645;5351.545118664918;4755.738434386108;4791.4250289965075;4810.95189048112;6107.541934354941;6445.806625801187;20434.386968390972;20553.8972305139;20963.895180524152;21742.673859892115;22641.207557735564;2116.5237821490196;2122.862013969087;2168.8373371997004;2210.502636906699;2826.660800703908;13469.191848489025;13557.389917453738;13646.727065458734;14005.5098071567;14234.501792437319;1863.3850829226324;1897.5730460646382;1920.8559358048203;1936.6514027475048;1947.9026048697651;48918;63911.04133438048;64514;74142;75573.62213188954;14215.50245741394;15016.099034057992;15082.396704131932;15244.695106098037;15907.363705451884;23947.640785388234;24166.154184603456;24239.878800605886;24270.87864560666;24379.17156213291;8682.348823838238;8749.1250874912;8989.235914947303;9028.413153145024;9069.682561110329;7511.286427789351;7540.396768258526;7558;7594.050743657043;7639.618019099023;7541.36052381662;7624.69501219945;7782;7784.182660820646;7791.298783109434;2974.7174018468213;3034.696530346948;3057.143999680093;3130.5617213590117;3142.6857314268846;836.6611522333465;900.320258205051;978.1734434403061;1034.1726618705006;1036.1969473657825;15881.28534215963;16482.34070637161;16616.418425355056;17099.23053462597;17170.65658686844;920.4799288402165;934.9158575728217;943.7499062748377;950.6007476859736;968.9757756056155;9318.161365477139;9497.382670126419;9540.379875308083;9559.426434413957;9780.853287200698;392956;395841;423175;423940;426132;71280;72284.63857680783;73655.26344736591;73808;76827.61586192145;1006.2603986070233;1020.4438580973388;1032.7108409645311;1036.7200855769051;1046.8115739166872;15131.167785771888;15434.614134646723;15764.92117539451;15941.521754347388;15964;33896.830515847265;33995;34163.48754768631;34367.31265374629;35541.466877997365;43568.56431435645;43679.56320436755;43909.56090439182;44198;44424.555754442044;7374.1151061872915;7571.356434702891;7588.772336829904;7592.772216833504;7667.233276672511;11696.649100526998;11803.645890623295;11887.346195959306;11937.164398492023;12157.756844862877;4780.784864681167;4818.469968303554;9060.229880460234;9570.090841370058;10108.545115469675;9524.714258572254;9968.651097211563;9992.65025724096;10002.499875006366;10276.640317588848;9835.360701554662;9999.850002250118;10065.547050382604;10148.340357876714;10383.688489345332;7225.349718525358;7522.811929701582;7597.6581053853815;7713.807154821175;7731.806704832424;9684.85472717924;9802.50987450639;9978.002199779963;9995.389946116817;10087.899121008695 05:59:20 INFO - PROCESS | 20398 | |3;mootools.html;1460.8685218330352;1470.4338829550622;1634.8528632423079;1744.5551384396977;1792.4801807475833;6482.935170648304;7332.596707181103;7447.776566703001;7602.353799927006;7611.276928691779;7457.403407727383;7492.175860655338;7544.094708634958;7544.735934242302;7556.69773209071;2212.192549719349;2230.6765518999737;2232.0290673556974;2239.0819763896807;2240.182333448296;2206.293985924505;2207.933761987143;2224.421650370907;2224.510607666311;2237.9328620141423;2220.600291947449;2230.2863083813186;2238.854474459163;2241.2715867343177;2261.7738226177416;2222.533268013719;2226.7661895500983;2237.932862014134;2239.2050821958296;2241.529278851443;2227.3095340444515;2228.621134407155;2230.6765518999655;2234.452559123009;2241.57410092082;7580.469367144302;7636.770896873103;7647.426443016796;7653;7655.234476552356;4537.886552836206;4649.767511624405;4667.906641867144;4670.602998745111;4672.929906051412;2942.1173647905543;3080.3993221321853;3089.9691003089906;3097.225693576606;3102.4105419970133;963.942163470194;970.2819913264204;970.7670159161821;999.1457304005116;1003.4731765823001;10283.897161028368;10291.279610427273;10311.278210525266;10347.534360953776;10353.585856565729;4060.7563546186734;4101.46680931477;4133.132042271097;4157.043879907638;4201.306784380543;8885.911140888638;8901.376903616814;8901.510416927002;8907.242884354902;8933.196012358789;4610.884727881829;4620.768961551977;4625.722456652612;4628.074385122989;4681.578657920735;4084.9795751021647;4216.641585465209;4223.831046758157;4225.661947044229;4269.850555230552;3317.1872891141825;3341.532185494033;3359.848806803651;3375.4430518964587;3378.611459682119;1015.040786456806;1016.7102375822855;1017.8829434615114;1029.7734498410339;1036.2487196782424;1278.9232646041082;1306.2489068785487;1329.4815022141372;1335.6727601737637;1336.0981337597084;6764.763233286812;6839.350261725128;6843.076184715;6867.278935711778;6890.483213758888;506.8200788720025;508.5905845794097;509.8113697931715;510.09967407525744;514.2954152810673;5353.892922141536;5360.812371566976;5396.1366181410785;5409.29679141709;5568.415316391802;8926.910730892609;9203.079692030877;9239.260859131253;9333.160015598492;9356.532173391302;8979.46123232608;9057.18485336323;9087;9127.589258483384;9208.493532855757;7222.602756848319;7286.162091359562;7298.963505182546;7314.487985841047;7314.561126332437;6943.132108486439;6980.441564674916;6989.895151572832;6993.300669932966;7060.54106483077;8098.433109682265;8366.916330836613;8374.49753014821;8384.958075209584;8451.873221901553;8182.304504117216;8415.45299555527;8474.237318641352;8498.320134389358;8613.69852055175;6418.614883107029;6457.7094030767785;6521.445677117498;6555.311692272243;6621.278467598556;7036.683349249399;7176.784696458905;7177.677004534704;7184.425245980414;7214.567125972459;6386.265579458422;6560.8359791005605;6573.3098024706715;6635.23694775107;6656.334366563305;6427.710753016219;6480.12518310041;6584.341565843569;6616.76841310571;6760.526763126534;6799.830004249933;6810.693518791765;6839.076724642109;6844.2129155147795;6844.486663500158;6280.780172693934;6303.36966303366;6381.234251889803;6384.170057892445;6419.358064193543;6264.655443950626;6288.905666414916;6312.4634406076;6333.20834895638;6338.619682819046 05:59:20 INFO - PROCESS | 20398 | |4;prototype.html;331.6583918563877;332.6473937626116;335.54533606962565;339.21471792799673;342.25388652737024;6120.938790612093;6154.938450615493;6218.968905155468;6221.6267023978535;6246.469050130733;6088.625436079932;6108.297545782225;6114.082887566856;6121.173641558388;6122.081687746829;4516.367708520794;4649.535046495357;4671.369365135705;4676.2050451423165;4698.295255711637;4670.602998745111;4680.040591678715;4684.859454216362;4690.624750019991;4698.201305778009;4617.769111544426;4626.028534007863;4635.8841028974375;4639.327297541854;4643.071385722852;4629.305604159386;4653.441587009546;4656.278276867091;4661.88345291367;4668.6731928765;4046.615571520701;4048.635622793933;4053.3919912013434;4055.087605288816;4058.9188216235807;5878.617889837147;5883.999720047602;5884.52923766102;5889.4993925515955;5906.852328691817;5241.475852414728;5324.41431442541;5346.97326513365;5369.301990741179;5370.624056316059;6447.1296374989715;6452.838679033015;6465.450436712885;6470.676466176672;6482.870342593122;4422.800973956179;4426.579474949875;4428.623566996809;4440.245158323093;4448.288273876165;6693.297203793581;6727.966360168266;6750.223724271723;6767.593944363305;6793.558418702769;4530.184566777945;4544.5682660147895;4554.453465584151;4559.179347717442;4568.223402021665;4442.600165985077;4558.407407037064;4571.22289210835;4598.908021839545;4602.309653551994;5326.2543243945875;5327.0145023170835;5327.813526526553;5344.946550534445;5348.251244825728;6491.156149700509;6502.837429064311;6505.512086593524;6519.739210431624;6534.901976470357;1598.79215701958;1618.741001439764;1620.2951716003577;1622.7971503562055;1628.5033064915315;1064.4677661169414;1081.5133190064503;1085.1969542538466;1096.0792933935531;1105.0993440346092;6234.127222188898;6255.24937007562;6268.49852011838;6274.780382686584;6277.24673039229;6675.566088204251;6689.966550167315;6690.899636505359;6691.895837186907;6701.195856497252;6176.474999625082;6190.690465476709;6265.780697675559;6349.174607301022;6374.362563743682;3622.3117607654463;3659.817009149585;3674.0998455378603;3678;3690.9261814763554;7185.748498802517;7191.928080719231;7229.963850180716;7314.853702926018;7329.926700733031;6887.173539175331;6953.408960238336;6970.128733908262;6978.441724662015;7014.473914456436;6933.791986240421;7077.292270772881;7093.1488221413765;7155.67799449026;7176.461765367722;6720.462363011045;6744.0558321834005;6758.898616520658;6795.218549866829;6799.966000169968;6628.536002479973;6634.9004764927595;6637.668116594247;6660.300668429745;6678.198616166092;7076.32774886385;7094.077769889881;7109.040279562193;7154.39187669054;7177.318154775288;4368.126374725131;4573.245414506569;4605.055963527402;4616.561426664462;4624.884377890445;6667.49993750461;6686.364795344434;6733.192016957996;6746.156730408699;6753.932460675527;6468.708908099241;6528.640924749185;6548.0832683425315;6549;6558.934410656023;6492.123563318892;6493.967530162319;6498.707558159988;6515.28331883502;6515.511336649675;6246.9062964054665;6352.872942541031;6367.745290188341;6383.2978372378075;6383.393577610305;6556.147700798866;6557.540972131905;6592.90110648331;6616.073749674953;6621.867562648817;6423.582467139621;6437.098806167047;6447.194100737408;6485.059666348258;6504.934950650622 05:59:20 INFO - PROCESS | 20398 | |5;yui.html;715.2239819795521;758.2947858491603;786.3984052200071;797.6450479536609;807.176679786618;13577.52478663247;13796.103253288542;13831.654208644788;13898.096623719477;13906.304684765772;12690.175138615983;13000.869991300084;13156.013299002565;13949;14009.439622415091;653.3923451190391;811.813282944923;826.2522417212432;826.404988408345;828.5443006346516;794.9761507154794;821.3388222480901;822.5722624235424;823.6293667849462;829.2205326992638;856.9014563325235;860.2429861721677;862.5299211929513;863.404251066762;864.9351298652595;851.9403641745112;853.0488505316589;855.4396870050127;856.195176534056;862.4997501449208;630.6878095342789;631.0439683878927;633.4109278371113;634.6414275934083;636.7484843486843;14088.71822563543;14115.153090814583;14158.646033849236;14168.716625667532;14209.218492982882;12780.424880880382;13281.800772988316;13349;13435.66410839727;13504.594862154052;10320.432376219305;10740.409277489734;10900.727481812939;10900.727481812939;10998.230123891331;4096.176303260758;4159.064210552601;4229.111886503838;4244;4288.44250247469;51075.23387149196;51436;51501;51605.74197129028;52214.47785522134;9594.1365277124;9614.134727874525;9777.31558790892;9855.31012829095;10131.83483899361;17833.732494012602;17874.910625446788;17911.462656120337;18000.369987050653;18025.459236222934;7383.30072275685;7888.053433588007;7899.249571290718;8030.9196908031345;8049.9597502013285;4118.4440100586635;4357.629601483909;4531.886702832389;4596.632269418438;4740.360051393018;3049.862756175933;3058.204866734665;3064.2798942248555;3070.416620842033;3090.2119959410206;545.1686178577621;560.3192121572309;562.943705629442;601.2334273800939;621.9937800621935;646.8156575375996;651.563452486835;652.9379708927644;656.6191608866845;661.9743584631044;8018.5990700464745;8061.677532898619;8488.618012189467;8547.230749232474;8627;541.1341853035112;550.1390324142784;604.8971674815292;625.8091282158986;638.5593940181353;3914.1388894443176;3974.7615143091507;3986.123052928409;4034.3343348347194;4147.730397524151;58230.7088464555;59236;59292.70353648204;59537.70231148903;59990.100148497804;50630.24054639183;51047;51335;51728.48271517312;51746.48253517417;45405.54594454013;45994;46059.39406059367;46239.537604624195;46536.30195547069;7804.570748608654;8200.876986845322;8285.668573257002;8342.332613391036;8505.404621676424;32307;34942;35263.47104793379;35356.305988979184;36231.456528151575;44231.33652995272;44496.77751611221;44815;45703;45897.082058359316;10702.197335200048;10889.237753357189;11004.889951100387;11026.283291586022;11354.716132096433;12138.696532586757;12210.389480526115;12298.938505307417;12336.568220112253;12881.162724422882;11191.776164476501;11368.431578421212;11488.368139752394;11721.06231501495;11736.589219377282;11174.441277936234;11303.208775385972;11648.475818588353;12000.819987700017;12046;10645.988631080036;10951.83572246433;11102.111831053335;11132.833007504732;11413.714657133638;9041.18629323364;9120.315976301936;9227;9296.95351523238;9518.095780900803;8441.36689748259;8453.196946290092;8535.829283414421;8803.515806630698;8885.644574216958 05:59:20 INFO - PROCESS | 20398 | __end_tp_report 05:59:20 INFO - PROCESS | 20398 | __start_cc_report 05:59:20 INFO - PROCESS | 20398 | _x_x_mozilla_cycle_collect,276 05:59:20 INFO - PROCESS | 20398 | __end_cc_report 05:59:20 INFO - PROCESS | 20398 | __startTimestamp1457186360068__endTimestamp 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | ------- Summary: start ------- 05:59:20 INFO - PROCESS | 20398 | Number of tests: 6 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | [#0] dojo.html Cycles:165 Average:5225.08 Median:5415.43 stddev:603.68 (11.1%) stddev-sans-first:581.62 05:59:20 INFO - PROCESS | 20398 | Values: 3081.0 3094.5 3143.0 3156.1 3183.1 5125.3 5189.4 5197.1 5209.8 5236.5 5244.7 5257.4 5281.1 5292.2 5315.5 4762.3 4780.7 4829.8 4909.0 4960.0 4867.9 4875.7 4913.5 4922.3 4950.9 4756.2 4784.5 4828.7 4865.9 4866.9 4754.3 4772.2 4794.9 4802.0 4808.3 4645.6 4672.5 4762.9 4774.9 4813.6 5028.9 5063.5 5102.8 5124.9 5143.7 5615.6 5636.8 5647.1 5653.9 5698.6 5503.4 5638.4 5694.7 5706.6 5732.6 5261.8 5265.2 5280.7 5292.3 5323.5 5773.2 5774.3 5783.1 5786.3 5798.3 5369.7 5510.2 5608.7 5642.1 5650.2 5578.6 5590.7 5595.9 5635.4 5644.5 5449.2 5547.0 5552.9 5557.9 5615.1 5385.8 5509.5 5517.3 5572.4 5598.2 4130.6 4154.2 4158.0 4188.0 4204.6 3716.6 3752.9 3755.6 3757.9 3767.0 5219.1 5289.9 5361.8 5366.1 5415.7 5591.0 5630.9 5632.3 5633.4 5650.2 5363.2 5380.3 5381.0 5389.8 5426.0 4638.2 4697.5 4753.2 4755.5 4787.3 5886.4 5891.1 5909.5 5916.8 5926.5 5518.1 5631.5 5640.7 5645.8 5648.6 5894.9 5943.4 5961.7 5963.0 5977.3 5582.2 5591.3 5599.8 5603.4 5621.2 5551.8 5653.5 5656.2 5666.1 5702.8 5390.5 5472.3 5483.2 5503.3 5554.0 5457.8 5504.1 5508.3 5515.3 5529.5 5293.7 5364.6 5391.6 5415.4 5443.5 5480.2 5531.8 5562.5 5563.2 5635.5 5377.1 5409.3 5414.9 5419.4 5442.5 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | [#1] ext.html Cycles:180 Average:42263.88 Median:36068.37 stddev:70153.36 (194.5%) stddev-sans-first:70280.00 05:59:20 INFO - PROCESS | 20398 | Values: 477.4 482.8 500.5 520.0 532.9 35553.8 36098.1 36312.5 36485.8 36516.0 39240.0 39861.4 39865.4 39890.2 39933.4 7907.4 8666.3 8676.6 8683.4 8706.4 8625.5 8740.2 8743.2 8778.7 8816.2 8754.8 8841.7 8856.9 8862.2 8885.6 8713.2 8783.6 8800.6 8805.8 8830.0 8643.8 8817.0 8852.7 8857.6 8905.1 38202.6 39402.2 39618.6 39628.6 39896.2 2896.7 3315.6 3335.7 3383.1 3390.6 27117.2 27561.4 27607.0 27832.4 28449.7 3550.6 3566.5 3576.7 3601.0 3640.2 188224.0 188247.0 188264.0 188377.0 188741.0 41106.6 41135.6 41588.2 41607.8 41798.8 39962.6 40062.8 40172.8 40278.0 40372.4 14854.1 15055.7 15072.5 15094.4 15100.8 11984.4 12025.1 12102.4 12122.4 12192.0 13958.6 14006.2 14008.0 14010.5 14055.5 5626.7 5750.3 5760.6 5761.5 5776.7 922.3 922.7 971.1 973.3 1000.2 27294.6 28199.9 28236.0 28562.4 28755.1 1039.8 1054.8 1085.1 1099.8 1114.4 14426.3 14539.5 14659.4 14832.2 14869.9 302340.0 303645.0 307451.0 307631.0 309074.0 50831.7 51193.0 51208.0 51503.7 51605.2 1294.4 1299.4 1334.6 1344.0 1344.4 26362.6 27727.2 27783.4 27835.7 28147.3 46299.5 46332.3 46500.3 46731.0 46807.8 291045.0 293252.0 294523.0 296392.0 298534.0 30786.7 31186.5 31400.7 31514.0 31551.0 43440.6 44231.8 44283.8 44290.8 44547.8 35292.6 36325.8 36448.8 36846.4 37167.3 36495.0 37064.3 37151.3 37258.0 37931.0 31147.4 35298.8 35811.8 36038.6 36942.4 29176.0 29906.3 30016.0 30073.5 30350.7 23094.5 24069.9 24262.2 24598.0 24912.0 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | [#2] jquery.html Cycles:180 Average:25169.06 Median:43794.56 stddev:67688.36 (154.6%) stddev-sans-first:67852.60 05:59:20 INFO - PROCESS | 20398 | Values: 350.8 351.7 355.3 356.1 360.8 16352.0 16587.3 17388.2 17701.6 17732.1 16300.5 16647.8 17112.0 17157.4 17174.1 5145.9 5168.1 5286.4 5390.1 5412.1 5358.2 5411.7 5446.8 5466.1 5471.3 5152.1 5350.8 5391.8 5422.0 5423.8 5308.4 5316.5 5335.3 5341.5 5351.5 4755.7 4791.4 4811.0 6107.5 6445.8 20434.4 20553.9 20963.9 21742.7 22641.2 2116.5 2122.9 2168.8 2210.5 2826.7 13469.2 13557.4 13646.7 14005.5 14234.5 1863.4 1897.6 1920.9 1936.7 1947.9 48918.0 63911.0 64514.0 74142.0 75573.6 14215.5 15016.1 15082.4 15244.7 15907.4 23947.6 24166.2 24239.9 24270.9 24379.2 8682.3 8749.1 8989.2 9028.4 9069.7 7511.3 7540.4 7558.0 7594.1 7639.6 7541.4 7624.7 7782.0 7784.2 7791.3 2974.7 3034.7 3057.1 3130.6 3142.7 836.7 900.3 978.2 1034.2 1036.2 15881.3 16482.3 16616.4 17099.2 17170.7 920.5 934.9 943.7 950.6 969.0 9318.2 9497.4 9540.4 9559.4 9780.9 392956.0 395841.0 423175.0 423940.0 426132.0 71280.0 72284.6 73655.3 73808.0 76827.6 1006.3 1020.4 1032.7 1036.7 1046.8 15131.2 15434.6 15764.9 15941.5 15964.0 33896.8 33995.0 34163.5 34367.3 35541.5 43568.6 43679.6 43909.6 44198.0 44424.6 7374.1 7571.4 7588.8 7592.8 7667.2 11696.6 11803.6 11887.3 11937.2 12157.8 4780.8 4818.5 9060.2 9570.1 10108.5 9524.7 9968.7 9992.7 10002.5 10276.6 9835.4 9999.9 10065.5 10148.3 10383.7 7225.3 7522.8 7597.7 7713.8 7731.8 9684.9 9802.5 9978.0 9995.4 10087.9 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | [#3] mootools.html Cycles:180 Average:5283.87 Median:6322.84 stddev:2756.43 (43.6%) stddev-sans-first:2749.19 05:59:20 INFO - PROCESS | 20398 | Values: 1460.9 1470.4 1634.9 1744.6 1792.5 6482.9 7332.6 7447.8 7602.4 7611.3 7457.4 7492.2 7544.1 7544.7 7556.7 2212.2 2230.7 2232.0 2239.1 2240.2 2206.3 2207.9 2224.4 2224.5 2237.9 2220.6 2230.3 2238.9 2241.3 2261.8 2222.5 2226.8 2237.9 2239.2 2241.5 2227.3 2228.6 2230.7 2234.5 2241.6 7580.5 7636.8 7647.4 7653.0 7655.2 4537.9 4649.8 4667.9 4670.6 4672.9 2942.1 3080.4 3090.0 3097.2 3102.4 963.9 970.3 970.8 999.1 1003.5 10283.9 10291.3 10311.3 10347.5 10353.6 4060.8 4101.5 4133.1 4157.0 4201.3 8885.9 8901.4 8901.5 8907.2 8933.2 4610.9 4620.8 4625.7 4628.1 4681.6 4085.0 4216.6 4223.8 4225.7 4269.9 3317.2 3341.5 3359.8 3375.4 3378.6 1015.0 1016.7 1017.9 1029.8 1036.2 1278.9 1306.2 1329.5 1335.7 1336.1 6764.8 6839.4 6843.1 6867.3 6890.5 506.8 508.6 509.8 510.1 514.3 5353.9 5360.8 5396.1 5409.3 5568.4 8926.9 9203.1 9239.3 9333.2 9356.5 8979.5 9057.2 9087.0 9127.6 9208.5 7222.6 7286.2 7299.0 7314.5 7314.6 6943.1 6980.4 6989.9 6993.3 7060.5 8098.4 8366.9 8374.5 8385.0 8451.9 8182.3 8415.5 8474.2 8498.3 8613.7 6418.6 6457.7 6521.4 6555.3 6621.3 7036.7 7176.8 7177.7 7184.4 7214.6 6386.3 6560.8 6573.3 6635.2 6656.3 6427.7 6480.1 6584.3 6616.8 6760.5 6799.8 6810.7 6839.1 6844.2 6844.5 6280.8 6303.4 6381.2 6384.2 6419.4 6264.7 6288.9 6312.5 6333.2 6338.6 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | [#4] prototype.html Cycles:180 Average:5451.37 Median:6227.88 stddev:1672.38 (26.9%) stddev-sans-first:1632.33 05:59:20 INFO - PROCESS | 20398 | Values: 331.7 332.6 335.5 339.2 342.3 6120.9 6154.9 6219.0 6221.6 6246.5 6088.6 6108.3 6114.1 6121.2 6122.1 4516.4 4649.5 4671.4 4676.2 4698.3 4670.6 4680.0 4684.9 4690.6 4698.2 4617.8 4626.0 4635.9 4639.3 4643.1 4629.3 4653.4 4656.3 4661.9 4668.7 4046.6 4048.6 4053.4 4055.1 4058.9 5878.6 5884.0 5884.5 5889.5 5906.9 5241.5 5324.4 5347.0 5369.3 5370.6 6447.1 6452.8 6465.5 6470.7 6482.9 4422.8 4426.6 4428.6 4440.2 4448.3 6693.3 6728.0 6750.2 6767.6 6793.6 4530.2 4544.6 4554.5 4559.2 4568.2 4442.6 4558.4 4571.2 4598.9 4602.3 5326.3 5327.0 5327.8 5344.9 5348.3 6491.2 6502.8 6505.5 6519.7 6534.9 1598.8 1618.7 1620.3 1622.8 1628.5 1064.5 1081.5 1085.2 1096.1 1105.1 6234.1 6255.2 6268.5 6274.8 6277.2 6675.6 6690.0 6690.9 6691.9 6701.2 6176.5 6190.7 6265.8 6349.2 6374.4 3622.3 3659.8 3674.1 3678.0 3690.9 7185.7 7191.9 7230.0 7314.9 7329.9 6887.2 6953.4 6970.1 6978.4 7014.5 6933.8 7077.3 7093.1 7155.7 7176.5 6720.5 6744.1 6758.9 6795.2 6800.0 6628.5 6634.9 6637.7 6660.3 6678.2 7076.3 7094.1 7109.0 7154.4 7177.3 4368.1 4573.2 4605.1 4616.6 4624.9 6667.5 6686.4 6733.2 6746.2 6753.9 6468.7 6528.6 6548.1 6549.0 6558.9 6492.1 6494.0 6498.7 6515.3 6515.5 6246.9 6352.9 6367.7 6383.3 6383.4 6556.1 6557.5 6592.9 6616.1 6621.9 6423.6 6437.1 6447.2 6485.1 6504.9 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - PROCESS | 20398 | [#5] yui.html Cycles:180 Average:13979.04 Median:27685.30 stddev:16290.62 (58.8%) stddev-sans-first:16305.86 05:59:20 INFO - PROCESS | 20398 | Values: 715.2 758.3 786.4 797.6 807.2 13577.5 13796.1 13831.7 13898.1 13906.3 12690.2 13000.9 13156.0 13949.0 14009.4 653.4 811.8 826.3 826.4 828.5 795.0 821.3 822.6 823.6 829.2 856.9 860.2 862.5 863.4 864.9 851.9 853.0 855.4 856.2 862.5 630.7 631.0 633.4 634.6 636.7 14088.7 14115.2 14158.6 14168.7 14209.2 12780.4 13281.8 13349.0 13435.7 13504.6 10320.4 10740.4 10900.7 10900.7 10998.2 4096.2 4159.1 4229.1 4244.0 4288.4 51075.2 51436.0 51501.0 51605.7 52214.5 9594.1 9614.1 9777.3 9855.3 10131.8 17833.7 17874.9 17911.5 18000.4 18025.5 7383.3 7888.1 7899.2 8030.9 8050.0 4118.4 4357.6 4531.9 4596.6 4740.4 3049.9 3058.2 3064.3 3070.4 3090.2 545.2 560.3 562.9 601.2 622.0 646.8 651.6 652.9 656.6 662.0 8018.6 8061.7 8488.6 8547.2 8627.0 541.1 550.1 604.9 625.8 638.6 3914.1 3974.8 3986.1 4034.3 4147.7 58230.7 59236.0 59292.7 59537.7 59990.1 50630.2 51047.0 51335.0 51728.5 51746.5 45405.5 45994.0 46059.4 46239.5 46536.3 7804.6 8200.9 8285.7 8342.3 8505.4 32307.0 34942.0 35263.5 35356.3 36231.5 44231.3 44496.8 44815.0 45703.0 45897.1 10702.2 10889.2 11004.9 11026.3 11354.7 12138.7 12210.4 12298.9 12336.6 12881.2 11191.8 11368.4 11488.4 11721.1 11736.6 11174.4 11303.2 11648.5 12000.8 12046.0 10646.0 10951.8 11102.1 11132.8 11413.7 9041.2 9120.3 9227.0 9297.0 9518.1 8441.4 8453.2 8535.8 8803.5 8885.6 05:59:20 INFO - PROCESS | 20398 | -------- Summary: end -------- 05:59:20 INFO - PROCESS | 20398 | 05:59:20 INFO - TEST-INFO | 20398: exit 0 05:59:20 INFO - TEST-OK | dromaeo_css | took 1109008ms 05:59:20 INFO - TEST-START | kraken 05:59:20 INFO - operating with platform_type : linux_ 05:59:20 INFO - Initialising browser for kraken test... 05:59:20 INFO - TEST-INFO | started process 20636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaEfLFe/profile http://localhost:43220/getInfo.html) 05:59:24 INFO - PROCESS | 20636 | 05:59:24 INFO - PROCESS | 20636 | (process:20706): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:24 INFO - PROCESS | 20636 | __metrics Screen width/height:1600/1200 05:59:24 INFO - PROCESS | 20636 | colorDepth:24 05:59:24 INFO - PROCESS | 20636 | Browser inner width/height: 1024/697 05:59:24 INFO - PROCESS | 20636 | __metrics 05:59:25 ERROR - PROCESS | 20636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:59:26 INFO - TEST-INFO | 20636: exit 0 05:59:26 INFO - Browser initialized. 05:59:26 INFO - Running cycle 1/1 for kraken test... 05:59:26 INFO - TEST-INFO | started process 20757 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaEfLFe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:27 INFO - PROCESS | 20757 | 05:59:27 INFO - PROCESS | 20757 | (process:20814): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:37 INFO - PROCESS | 20757 | RSS: Main: 160681984 05:59:37 INFO - PROCESS | 20757 | 05:59:40 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43220/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:40 INFO - PROCESS | 20757 | RSS: Main: 167780352 05:59:40 INFO - PROCESS | 20757 | 05:59:43 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43220/tests/kraken/driver.html?testName=audio-dft) 05:59:44 INFO - PROCESS | 20757 | RSS: Main: 169775104 05:59:44 INFO - PROCESS | 20757 | 05:59:46 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43220/tests/kraken/driver.html?testName=audio-fft) 05:59:47 INFO - PROCESS | 20757 | RSS: Main: 164569088 05:59:47 INFO - PROCESS | 20757 | 05:59:49 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43220/tests/kraken/driver.html?testName=audio-oscillator) 05:59:50 INFO - PROCESS | 20757 | RSS: Main: 164220928 05:59:50 INFO - PROCESS | 20757 | 05:59:52 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:52 INFO - PROCESS | 20757 | RSS: Main: 166498304 05:59:52 INFO - PROCESS | 20757 | 05:59:55 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43220/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:56 INFO - PROCESS | 20757 | RSS: Main: 166531072 05:59:56 INFO - PROCESS | 20757 | 05:59:59 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43220/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:00 INFO - PROCESS | 20757 | RSS: Main: 167096320 06:00:00 INFO - PROCESS | 20757 | 06:00:03 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43220/tests/kraken/driver.html?testName=json-parse-financial) 06:00:03 INFO - PROCESS | 20757 | RSS: Main: 167227392 06:00:03 INFO - PROCESS | 20757 | 06:00:05 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:05 INFO - PROCESS | 20757 | RSS: Main: 165855232 06:00:05 INFO - PROCESS | 20757 | 06:00:07 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:08 INFO - PROCESS | 20757 | RSS: Main: 165421056 06:00:08 INFO - PROCESS | 20757 | 06:00:10 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:10 INFO - PROCESS | 20757 | RSS: Main: 166080512 06:00:10 INFO - PROCESS | 20757 | 06:00:13 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:13 INFO - PROCESS | 20757 | RSS: Main: 165421056 06:00:13 INFO - PROCESS | 20757 | 06:00:16 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:17 INFO - PROCESS | 20757 | RSS: Main: 166182912 06:00:17 INFO - PROCESS | 20757 | 06:00:18 INFO - PROCESS | 20757 | Cycle 1(1): loaded http://localhost:43220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43220/tests/kraken/driver.html?testName=ai-astar) 06:00:19 INFO - PROCESS | 20757 | RSS: Main: 167845888 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | __start_tp_report 06:00:19 INFO - PROCESS | 20757 | _x_x_mozilla_page_load 06:00:19 INFO - PROCESS | 20757 | _x_x_mozilla_page_load_details 06:00:19 INFO - PROCESS | 20757 | |i|pagename|runs| 06:00:19 INFO - PROCESS | 20757 | |0;ai-astar;113;109;114;113;114;125;114;112;113;117 06:00:19 INFO - PROCESS | 20757 | |1;audio-beat-detection;156;134;158;177;140;156;157;135;172;137 06:00:19 INFO - PROCESS | 20757 | |2;audio-dft;165;164;165;168;164;165;168;164;171;182 06:00:19 INFO - PROCESS | 20757 | |3;audio-fft;76;75;75;76;78;76;77;141;75;73 06:00:19 INFO - PROCESS | 20757 | |4;audio-oscillator;95;104;135;95;95;94;135;95;96;135 06:00:19 INFO - PROCESS | 20757 | |5;imaging-gaussian-blur;119;120;124;119;119;120;119;121;121;119 06:00:19 INFO - PROCESS | 20757 | |6;imaging-darkroom;149;149;148;148;150;147;149;148;149;148 06:00:19 INFO - PROCESS | 20757 | |7;imaging-desaturate;98;98;98;101;97;102;98;98;98;97 06:00:19 INFO - PROCESS | 20757 | |8;json-parse-financial;59;59;59;59;59;59;60;60;57;57 06:00:19 INFO - PROCESS | 20757 | |9;json-stringify-tinderbox;67;69;68;68;67;68;67;69;68;68 06:00:19 INFO - PROCESS | 20757 | |10;stanford-crypto-aes;84;87;86;85;86;85;92;92;91;91 06:00:19 INFO - PROCESS | 20757 | |11;stanford-crypto-ccm;132;122;127;130;127;132;123;143;121;131 06:00:19 INFO - PROCESS | 20757 | |12;stanford-crypto-pbkdf2;151;147;161;149;173;159;162;157;151;149 06:00:19 INFO - PROCESS | 20757 | |13;stanford-crypto-sha256-iterative;71;70;71;74;72;70;72;73;70;70 06:00:19 INFO - PROCESS | 20757 | __end_tp_report 06:00:19 INFO - PROCESS | 20757 | __start_cc_report 06:00:19 INFO - PROCESS | 20757 | _x_x_mozilla_cycle_collect,696 06:00:19 INFO - PROCESS | 20757 | __end_cc_report 06:00:19 INFO - PROCESS | 20757 | __startTimestamp1457186419059__endTimestamp 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | ------- Summary: start ------- 06:00:19 INFO - PROCESS | 20757 | Number of tests: 14 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.22 (3.7%) stddev-sans-first:4.45 06:00:19 INFO - PROCESS | 20757 | Values: 113.0 109.0 114.0 113.0 114.0 125.0 114.0 112.0 113.0 117.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:156.50 stddev:15.27 (9.8%) stddev-sans-first:16.14 06:00:19 INFO - PROCESS | 20757 | Values: 156.0 134.0 158.0 177.0 140.0 156.0 157.0 135.0 172.0 137.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#2] audio-dft Cycles:10 Average:167.60 Median:166.50 stddev:5.56 (3.3%) stddev-sans-first:5.82 06:00:19 INFO - PROCESS | 20757 | Values: 165.0 164.0 165.0 168.0 164.0 165.0 168.0 164.0 171.0 182.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:20.70 (27.2%) stddev-sans-first:21.84 06:00:19 INFO - PROCESS | 20757 | Values: 76.0 75.0 75.0 76.0 78.0 76.0 77.0 141.0 75.0 73.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.00 stddev:18.91 (19.9%) stddev-sans-first:19.47 06:00:19 INFO - PROCESS | 20757 | Values: 95.0 104.0 135.0 95.0 95.0 94.0 135.0 95.0 96.0 135.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#5] imaging-gaussian-blur Cycles:10 Average:120.10 Median:120.00 stddev:1.60 (1.3%) stddev-sans-first:1.64 06:00:19 INFO - PROCESS | 20757 | Values: 119.0 120.0 124.0 119.0 119.0 120.0 119.0 121.0 121.0 119.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 06:00:19 INFO - PROCESS | 20757 | Values: 149.0 149.0 148.0 148.0 150.0 147.0 149.0 148.0 149.0 148.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#7] imaging-desaturate Cycles:10 Average:98.50 Median:98.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 06:00:19 INFO - PROCESS | 20757 | Values: 98.0 98.0 98.0 101.0 97.0 102.0 98.0 98.0 98.0 97.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 06:00:19 INFO - PROCESS | 20757 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 57.0 57.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 06:00:19 INFO - PROCESS | 20757 | Values: 67.0 69.0 68.0 68.0 67.0 68.0 67.0 69.0 68.0 68.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:89.00 stddev:3.21 (3.6%) stddev-sans-first:3.08 06:00:19 INFO - PROCESS | 20757 | Values: 84.0 87.0 86.0 85.0 86.0 85.0 92.0 92.0 91.0 91.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:130.50 stddev:6.46 (5.0%) stddev-sans-first:6.75 06:00:19 INFO - PROCESS | 20757 | Values: 132.0 122.0 127.0 130.0 127.0 132.0 123.0 143.0 121.0 131.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:158.00 stddev:8.09 (5.1%) stddev-sans-first:8.38 06:00:19 INFO - PROCESS | 20757 | Values: 151.0 147.0 161.0 149.0 173.0 159.0 162.0 157.0 151.0 149.0 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - PROCESS | 20757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.42 (2.0%) stddev-sans-first:1.50 06:00:19 INFO - PROCESS | 20757 | Values: 71.0 70.0 71.0 74.0 72.0 70.0 72.0 73.0 70.0 70.0 06:00:19 INFO - PROCESS | 20757 | -------- Summary: end -------- 06:00:19 INFO - PROCESS | 20757 | 06:00:19 INFO - TEST-INFO | 20757: exit 0 06:00:19 INFO - TEST-OK | kraken | took 59216ms 06:00:19 INFO - SUITE-END | took 1168s 06:00:20 INFO - Completed test suite (00:19:28) 06:00:20 INFO - javascript benchmark 06:00:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.0140754958416, 3094.473939430295, 3142.9685703142964, 3156.1162874395177, 3183.0928185467137, 5125.308083408739, 5189.351331083614, 5197.064528384889, 5209.817656382027, 5236.528712415882, 5244.711540865251, 5257.369115706111, 5281.075811732941, 5292.2061690746405, 5315.468453154683, 4762.261849413329, 4780.73705946172, 4829.7585120744, 4908.975455122737, 4959.95840873417, 4867.904721437683, 4875.70745755254, 4913.459519452857, 4922.286268491067, 4950.87622809429, 4756.215224487973, 4784.497627749089, 4828.686135401188, 4865.902681946377, 4866.926996095061, 4754.286856971482, 4772.2125849234835, 4794.9280760788615, 4801.95198048022, 4808.2547205183255, 4645.605123564501, 4672.462666793328, 4762.880723030085, 4774.904501909942, 4813.638977076698, 5028.874278143076, 5063.468335824722, 5102.846914592568, 5124.871878203037, 5143.717095559743, 5615.5507559395555, 5636.774529018834, 5647.0964645656495, 5653.8586535336535, 5698.572607054488, 5503.367112782042, 5638.407967163471, 5694.658320500742, 5706.600537962344, 5732.5987180897355, 5261.789528418859, 5265.236540701615, 5280.735963201863, 5292.311999440049, 5323.467653234684, 5773.220615216976, 5774.278215223013, 5783.1325301204315, 5786.334571524244, 5798.304203495523, 5369.677819330853, 5510.228568000483, 5608.691521966331, 5642.069058605366, 5650.152477128464, 5578.553715702734, 5590.664560126405, 5595.888082238333, 5635.436456354331, 5644.463775941279, 5449.237106805051, 5547.001539722808, 5552.888942221133, 5557.916631250535, 5615.129654903497, 5385.7576409061685, 5509.531689806331, 5517.282753242052, 5572.3870374258795, 5598.188262701886, 4130.6282434580435, 4154.231467178582, 4157.97921010393, 4188.036751547162, 4204.600562946576, 3716.6283371663158, 3752.9061773455883, 3755.586885442599, 3757.9436308455397, 3767.0394049517745, 5219.1388420910125, 5289.894202115936, 5361.839144825662, 5366.114591092504, 5415.675059496442, 5591.021571225019, 5630.915536266959, 5632.267805185382, 5633.408492108351, 5650.208970744099, 5363.222332761806, 5380.273663055437, 5381.0, 5389.757460914268, 5426.0, 4638.234691275901, 4697.4832768395445, 4753.191957367256, 4755.548222918817, 4787.257975013878, 5886.440788125121, 5891.086881533369, 5909.527237820964, 5916.792912248051, 5926.525877929756, 5518.061929471919, 5631.465010823965, 5640.661560306395, 5645.774169033357, 5648.604597678123, 5894.911576326273, 5943.435373639497, 5961.701914904324, 5962.97018514922, 5977.3126090500145, 5582.246396736388, 5591.27313449249, 5599.80400685974, 5603.411641777555, 5621.213030175861, 5551.805686800943, 5653.462921022497, 5656.208130861765, 5666.121751128417, 5702.8289151325525, 5390.4879036491475, 5472.288602481811, 5483.2323474712775, 5503.284573005483, 5554.0, 5457.836264912059, 5504.091824849015, 5508.283923089973, 5515.338159420895, 5529.529989950899, 5293.735313234246, 5364.624476286623, 5391.595630327663, 5415.4313797050745, 5443.510084092451, 5480.205370221375, 5531.834044978657, 5562.527185189304, 5563.248961390323, 5635.492805647511, 5377.059014672339, 5409.323834520685, 5414.891702166014, 5419.403865574863, 5442.455754424526], "unit": "score", "name": "dojo.html", "value": 5184.186516338195}, {"lowerIsBetter": false, "replicates": [477.43900916423195, 482.8310091467987, 500.4870008241552, 520.0223579670219, 532.936047674279, 35553.82223088884, 36098.097547561294, 36312.455313170256, 36485.81757091214, 36516.0, 39240.0, 39861.40207896884, 39865.40201896974, 39890.20219595614, 39933.400998984966, 7907.44647874649, 8666.306695464347, 8676.60955257015, 8683.435576687527, 8706.390552661316, 8625.482471051757, 8740.213380795727, 8743.169398907094, 8778.6927457539, 8816.162464565889, 8754.824903501925, 8841.690540831072, 8856.8671469928, 8862.24670902974, 8885.644574217056, 8713.215810577047, 8783.560821958908, 8800.603972821174, 8805.779855503599, 8829.95585022074, 8643.83308253384, 8816.955915220447, 8852.690155844579, 8857.645694172226, 8905.109489051109, 38202.61797382018, 39402.21195576101, 39618.603813962065, 39628.603713963064, 39896.20207595832, 2896.7392934635773, 3315.635280119185, 3335.7498187635783, 3383.1203886989315, 3390.5761779777526, 27117.186484405498, 27561.44877102467, 27607.0, 27832.443351132864, 28449.71550284512, 3550.5916819565564, 3566.5185199998186, 3576.660217279354, 3600.9562705448698, 3640.1809592841664, 188224.0, 188247.0, 188264.0, 188377.0, 188741.0, 41106.58893411088, 41135.58864411378, 41588.168236635705, 41607.75176744642, 41798.791006044776, 39962.60037399589, 40062.79968600138, 40172.799136004716, 40278.0, 40372.394414083814, 14854.108753474826, 15055.698886022437, 15072.472463463726, 15094.39622415091, 15100.773488397683, 11984.400779960966, 12025.098117641212, 12102.394880255952, 12122.393880306126, 12192.0, 13958.58124256274, 14006.229657368738, 14008.0, 14010.509632162826, 14055.470015397326, 5626.718664066781, 5750.281214848144, 5760.567957403127, 5761.452661997104, 5776.68228247442, 922.3128769067088, 922.7001224601897, 971.0677749360551, 973.2749101919115, 1000.1698590170141, 27294.5905811413, 28199.88614706837, 28236.0, 28562.428751424854, 28755.13734587966, 1039.838824982129, 1054.7890421915647, 1085.1210519479248, 1099.7910397024539, 1114.4149321606221, 14426.278686065654, 14539.491117810825, 14659.413623455155, 14832.18422986746, 14869.851301486846, 302340.0, 303645.0, 307451.0, 307631.0, 309074.0, 50831.745841271295, 51193.0, 51208.0, 51503.74248128735, 51605.22592161046, 1294.4175121195499, 1299.3762993762857, 1334.6463187255579, 1343.9596812095654, 1344.37486568746, 26362.604560931984, 27727.168184954484, 27783.444331113667, 27835.721642784123, 28147.296317592223, 46299.53700463087, 46332.30501542412, 46500.30249546192, 46731.0, 46807.76596116998, 291045.0, 293252.0, 294523.0, 296392.0, 298534.0, 30786.69213307838, 31186.532202017443, 31400.68599314069, 31514.0, 31551.0, 43440.56559434365, 44231.77884110559, 44283.77858110689, 44290.77854610706, 44547.777261113486, 35292.64707352893, 36325.818370907975, 36448.81775591105, 36846.44730329101, 37167.25665486729, 36495.0, 37064.25871482609, 37151.256974860895, 37258.0, 37931.0, 31147.37705245837, 35298.823505882305, 35811.82094089513, 36038.639613603526, 36942.44586331261, 29176.0, 29906.252343691584, 30016.0, 30073.548896767003, 30350.696493034786, 23094.538109237386, 24069.879650601633, 24262.15082472105, 24598.0, 24912.0], "unit": "score", "name": "ext.html", "value": 17265.155133213084}, {"lowerIsBetter": false, "replicates": [350.8070561191344, 351.6782144337931, 355.2787840683412, 356.1381456874364, 360.80877135118396, 16352.018878867277, 16587.253573589187, 17388.217530211125, 17701.55746106348, 17732.113394330296, 16300.510984670478, 16647.83352166478, 17112.0, 17157.399491017815, 17174.141292935336, 5145.948540514593, 5168.147255702805, 5286.4449232830575, 5390.110631745757, 5412.107002344628, 5358.223057656637, 5411.729413529328, 5446.809361672343, 5466.125419932811, 5471.343438787351, 5152.1498952672955, 5350.839474815762, 5391.81128660497, 5421.972890135544, 5423.755930983115, 5308.389535203443, 5316.521513063804, 5335.253064570963, 5341.4925582069645, 5351.545118664918, 4755.738434386108, 4791.4250289965075, 4810.95189048112, 6107.541934354941, 6445.806625801187, 20434.386968390972, 20553.8972305139, 20963.895180524152, 21742.673859892115, 22641.207557735564, 2116.5237821490196, 2122.862013969087, 2168.8373371997004, 2210.502636906699, 2826.660800703908, 13469.191848489025, 13557.389917453738, 13646.727065458734, 14005.5098071567, 14234.501792437319, 1863.3850829226324, 1897.5730460646382, 1920.8559358048203, 1936.6514027475048, 1947.9026048697651, 48918.0, 63911.04133438048, 64514.0, 74142.0, 75573.62213188954, 14215.50245741394, 15016.099034057992, 15082.396704131932, 15244.695106098037, 15907.363705451884, 23947.640785388234, 24166.154184603456, 24239.878800605886, 24270.87864560666, 24379.17156213291, 8682.348823838238, 8749.1250874912, 8989.235914947303, 9028.413153145024, 9069.682561110329, 7511.286427789351, 7540.396768258526, 7558.0, 7594.050743657043, 7639.618019099023, 7541.36052381662, 7624.69501219945, 7782.0, 7784.182660820646, 7791.298783109434, 2974.7174018468213, 3034.696530346948, 3057.143999680093, 3130.5617213590117, 3142.6857314268846, 836.6611522333465, 900.320258205051, 978.1734434403061, 1034.1726618705006, 1036.1969473657825, 15881.28534215963, 16482.34070637161, 16616.418425355056, 17099.23053462597, 17170.65658686844, 920.4799288402165, 934.9158575728217, 943.7499062748377, 950.6007476859736, 968.9757756056155, 9318.161365477139, 9497.382670126419, 9540.379875308083, 9559.426434413957, 9780.853287200698, 392956.0, 395841.0, 423175.0, 423940.0, 426132.0, 71280.0, 72284.63857680783, 73655.26344736591, 73808.0, 76827.61586192145, 1006.2603986070233, 1020.4438580973388, 1032.7108409645311, 1036.7200855769051, 1046.8115739166872, 15131.167785771888, 15434.614134646723, 15764.92117539451, 15941.521754347388, 15964.0, 33896.830515847265, 33995.0, 34163.48754768631, 34367.31265374629, 35541.466877997365, 43568.56431435645, 43679.56320436755, 43909.56090439182, 44198.0, 44424.555754442044, 7374.1151061872915, 7571.356434702891, 7588.772336829904, 7592.772216833504, 7667.233276672511, 11696.649100526998, 11803.645890623295, 11887.346195959306, 11937.164398492023, 12157.756844862877, 4780.784864681167, 4818.469968303554, 9060.229880460234, 9570.090841370058, 10108.545115469675, 9524.714258572254, 9968.651097211563, 9992.65025724096, 10002.499875006366, 10276.640317588848, 9835.360701554662, 9999.850002250118, 10065.547050382604, 10148.340357876714, 10383.688489345332, 7225.349718525358, 7522.811929701582, 7597.6581053853815, 7713.807154821175, 7731.806704832424, 9684.85472717924, 9802.50987450639, 9978.002199779963, 9995.389946116817, 10087.899121008695], "unit": "score", "name": "jquery.html", "value": 8848.015851455677}, {"lowerIsBetter": false, "replicates": [1460.8685218330352, 1470.4338829550622, 1634.8528632423079, 1744.5551384396977, 1792.4801807475833, 6482.935170648304, 7332.596707181103, 7447.776566703001, 7602.353799927006, 7611.276928691779, 7457.403407727383, 7492.175860655338, 7544.094708634958, 7544.735934242302, 7556.69773209071, 2212.192549719349, 2230.6765518999737, 2232.0290673556974, 2239.0819763896807, 2240.182333448296, 2206.293985924505, 2207.933761987143, 2224.421650370907, 2224.510607666311, 2237.9328620141423, 2220.600291947449, 2230.2863083813186, 2238.854474459163, 2241.2715867343177, 2261.7738226177416, 2222.533268013719, 2226.7661895500983, 2237.932862014134, 2239.2050821958296, 2241.529278851443, 2227.3095340444515, 2228.621134407155, 2230.6765518999655, 2234.452559123009, 2241.57410092082, 7580.469367144302, 7636.770896873103, 7647.426443016796, 7653.0, 7655.234476552356, 4537.886552836206, 4649.767511624405, 4667.906641867144, 4670.602998745111, 4672.929906051412, 2942.1173647905543, 3080.3993221321853, 3089.9691003089906, 3097.225693576606, 3102.4105419970133, 963.942163470194, 970.2819913264204, 970.7670159161821, 999.1457304005116, 1003.4731765823001, 10283.897161028368, 10291.279610427273, 10311.278210525266, 10347.534360953776, 10353.585856565729, 4060.7563546186734, 4101.46680931477, 4133.132042271097, 4157.043879907638, 4201.306784380543, 8885.911140888638, 8901.376903616814, 8901.510416927002, 8907.242884354902, 8933.196012358789, 4610.884727881829, 4620.768961551977, 4625.722456652612, 4628.074385122989, 4681.578657920735, 4084.9795751021647, 4216.641585465209, 4223.831046758157, 4225.661947044229, 4269.850555230552, 3317.1872891141825, 3341.532185494033, 3359.848806803651, 3375.4430518964587, 3378.611459682119, 1015.040786456806, 1016.7102375822855, 1017.8829434615114, 1029.7734498410339, 1036.2487196782424, 1278.9232646041082, 1306.2489068785487, 1329.4815022141372, 1335.6727601737637, 1336.0981337597084, 6764.763233286812, 6839.350261725128, 6843.076184715, 6867.278935711778, 6890.483213758888, 506.8200788720025, 508.5905845794097, 509.8113697931715, 510.09967407525744, 514.2954152810673, 5353.892922141536, 5360.812371566976, 5396.1366181410785, 5409.29679141709, 5568.415316391802, 8926.910730892609, 9203.079692030877, 9239.260859131253, 9333.160015598492, 9356.532173391302, 8979.46123232608, 9057.18485336323, 9087.0, 9127.589258483384, 9208.493532855757, 7222.602756848319, 7286.162091359562, 7298.963505182546, 7314.487985841047, 7314.561126332437, 6943.132108486439, 6980.441564674916, 6989.895151572832, 6993.300669932966, 7060.54106483077, 8098.433109682265, 8366.916330836613, 8374.49753014821, 8384.958075209584, 8451.873221901553, 8182.304504117216, 8415.45299555527, 8474.237318641352, 8498.320134389358, 8613.69852055175, 6418.614883107029, 6457.7094030767785, 6521.445677117498, 6555.311692272243, 6621.278467598556, 7036.683349249399, 7176.784696458905, 7177.677004534704, 7184.425245980414, 7214.567125972459, 6386.265579458422, 6560.8359791005605, 6573.3098024706715, 6635.23694775107, 6656.334366563305, 6427.710753016219, 6480.12518310041, 6584.341565843569, 6616.76841310571, 6760.526763126534, 6799.830004249933, 6810.693518791765, 6839.076724642109, 6844.2129155147795, 6844.486663500158, 6280.780172693934, 6303.36966303366, 6381.234251889803, 6384.170057892445, 6419.358064193543, 6264.655443950626, 6288.905666414916, 6312.4634406076, 6333.20834895638, 6338.619682819046], "unit": "score", "name": "mootools.html", "value": 4281.9041920807285}, {"lowerIsBetter": false, "replicates": [331.6583918563877, 332.6473937626116, 335.54533606962565, 339.21471792799673, 342.25388652737024, 6120.938790612093, 6154.938450615493, 6218.968905155468, 6221.6267023978535, 6246.469050130733, 6088.625436079932, 6108.297545782225, 6114.082887566856, 6121.173641558388, 6122.081687746829, 4516.367708520794, 4649.535046495357, 4671.369365135705, 4676.2050451423165, 4698.295255711637, 4670.602998745111, 4680.040591678715, 4684.859454216362, 4690.624750019991, 4698.201305778009, 4617.769111544426, 4626.028534007863, 4635.8841028974375, 4639.327297541854, 4643.071385722852, 4629.305604159386, 4653.441587009546, 4656.278276867091, 4661.88345291367, 4668.6731928765, 4046.615571520701, 4048.635622793933, 4053.3919912013434, 4055.087605288816, 4058.9188216235807, 5878.617889837147, 5883.999720047602, 5884.52923766102, 5889.4993925515955, 5906.852328691817, 5241.475852414728, 5324.41431442541, 5346.97326513365, 5369.301990741179, 5370.624056316059, 6447.1296374989715, 6452.838679033015, 6465.450436712885, 6470.676466176672, 6482.870342593122, 4422.800973956179, 4426.579474949875, 4428.623566996809, 4440.245158323093, 4448.288273876165, 6693.297203793581, 6727.966360168266, 6750.223724271723, 6767.593944363305, 6793.558418702769, 4530.184566777945, 4544.5682660147895, 4554.453465584151, 4559.179347717442, 4568.223402021665, 4442.600165985077, 4558.407407037064, 4571.22289210835, 4598.908021839545, 4602.309653551994, 5326.2543243945875, 5327.0145023170835, 5327.813526526553, 5344.946550534445, 5348.251244825728, 6491.156149700509, 6502.837429064311, 6505.512086593524, 6519.739210431624, 6534.901976470357, 1598.79215701958, 1618.741001439764, 1620.2951716003577, 1622.7971503562055, 1628.5033064915315, 1064.4677661169414, 1081.5133190064503, 1085.1969542538466, 1096.0792933935531, 1105.0993440346092, 6234.127222188898, 6255.24937007562, 6268.49852011838, 6274.780382686584, 6277.24673039229, 6675.566088204251, 6689.966550167315, 6690.899636505359, 6691.895837186907, 6701.195856497252, 6176.474999625082, 6190.690465476709, 6265.780697675559, 6349.174607301022, 6374.362563743682, 3622.3117607654463, 3659.817009149585, 3674.0998455378603, 3678.0, 3690.9261814763554, 7185.748498802517, 7191.928080719231, 7229.963850180716, 7314.853702926018, 7329.926700733031, 6887.173539175331, 6953.408960238336, 6970.128733908262, 6978.441724662015, 7014.473914456436, 6933.791986240421, 7077.292270772881, 7093.1488221413765, 7155.67799449026, 7176.461765367722, 6720.462363011045, 6744.0558321834005, 6758.898616520658, 6795.218549866829, 6799.966000169968, 6628.536002479973, 6634.9004764927595, 6637.668116594247, 6660.300668429745, 6678.198616166092, 7076.32774886385, 7094.077769889881, 7109.040279562193, 7154.39187669054, 7177.318154775288, 4368.126374725131, 4573.245414506569, 4605.055963527402, 4616.561426664462, 4624.884377890445, 6667.49993750461, 6686.364795344434, 6733.192016957996, 6746.156730408699, 6753.932460675527, 6468.708908099241, 6528.640924749185, 6548.0832683425315, 6549.0, 6558.934410656023, 6492.123563318892, 6493.967530162319, 6498.707558159988, 6515.28331883502, 6515.511336649675, 6246.9062964054665, 6352.872942541031, 6367.745290188341, 6383.2978372378075, 6383.393577610305, 6556.147700798866, 6557.540972131905, 6592.90110648331, 6616.073749674953, 6621.867562648817, 6423.582467139621, 6437.098806167047, 6447.194100737408, 6485.059666348258, 6504.934950650622], "unit": "score", "name": "prototype.html", "value": 4903.520251427414}, {"lowerIsBetter": false, "replicates": [715.2239819795521, 758.2947858491603, 786.3984052200071, 797.6450479536609, 807.176679786618, 13577.52478663247, 13796.103253288542, 13831.654208644788, 13898.096623719477, 13906.304684765772, 12690.175138615983, 13000.869991300084, 13156.013299002565, 13949.0, 14009.439622415091, 653.3923451190391, 811.813282944923, 826.2522417212432, 826.404988408345, 828.5443006346516, 794.9761507154794, 821.3388222480901, 822.5722624235424, 823.6293667849462, 829.2205326992638, 856.9014563325235, 860.2429861721677, 862.5299211929513, 863.404251066762, 864.9351298652595, 851.9403641745112, 853.0488505316589, 855.4396870050127, 856.195176534056, 862.4997501449208, 630.6878095342789, 631.0439683878927, 633.4109278371113, 634.6414275934083, 636.7484843486843, 14088.71822563543, 14115.153090814583, 14158.646033849236, 14168.716625667532, 14209.218492982882, 12780.424880880382, 13281.800772988316, 13349.0, 13435.66410839727, 13504.594862154052, 10320.432376219305, 10740.409277489734, 10900.727481812939, 10900.727481812939, 10998.230123891331, 4096.176303260758, 4159.064210552601, 4229.111886503838, 4244.0, 4288.44250247469, 51075.23387149196, 51436.0, 51501.0, 51605.74197129028, 52214.47785522134, 9594.1365277124, 9614.134727874525, 9777.31558790892, 9855.31012829095, 10131.83483899361, 17833.732494012602, 17874.910625446788, 17911.462656120337, 18000.369987050653, 18025.459236222934, 7383.30072275685, 7888.053433588007, 7899.249571290718, 8030.9196908031345, 8049.9597502013285, 4118.4440100586635, 4357.629601483909, 4531.886702832389, 4596.632269418438, 4740.360051393018, 3049.862756175933, 3058.204866734665, 3064.2798942248555, 3070.416620842033, 3090.2119959410206, 545.1686178577621, 560.3192121572309, 562.943705629442, 601.2334273800939, 621.9937800621935, 646.8156575375996, 651.563452486835, 652.9379708927644, 656.6191608866845, 661.9743584631044, 8018.5990700464745, 8061.677532898619, 8488.618012189467, 8547.230749232474, 8627.0, 541.1341853035112, 550.1390324142784, 604.8971674815292, 625.8091282158986, 638.5593940181353, 3914.1388894443176, 3974.7615143091507, 3986.123052928409, 4034.3343348347194, 4147.730397524151, 58230.7088464555, 59236.0, 59292.70353648204, 59537.70231148903, 59990.100148497804, 50630.24054639183, 51047.0, 51335.0, 51728.48271517312, 51746.48253517417, 45405.54594454013, 45994.0, 46059.39406059367, 46239.537604624195, 46536.30195547069, 7804.570748608654, 8200.876986845322, 8285.668573257002, 8342.332613391036, 8505.404621676424, 32307.0, 34942.0, 35263.47104793379, 35356.305988979184, 36231.456528151575, 44231.33652995272, 44496.77751611221, 44815.0, 45703.0, 45897.082058359316, 10702.197335200048, 10889.237753357189, 11004.889951100387, 11026.283291586022, 11354.716132096433, 12138.696532586757, 12210.389480526115, 12298.938505307417, 12336.568220112253, 12881.162724422882, 11191.776164476501, 11368.431578421212, 11488.368139752394, 11721.06231501495, 11736.589219377282, 11174.441277936234, 11303.208775385972, 11648.475818588353, 12000.819987700017, 12046.0, 10645.988631080036, 10951.83572246433, 11102.111831053335, 11132.833007504732, 11413.714657133638, 9041.18629323364, 9120.315976301936, 9227.0, 9296.95351523238, 9518.095780900803, 8441.36689748259, 8453.196946290092, 8535.829283414421, 8803.515806630698, 8885.644574216958], "unit": "score", "name": "yui.html", "value": 6346.968635037361}], "name": "dromaeo_css", "value": 6874.497203338423}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 113.0, 114.0, 125.0, 114.0, 112.0, 113.0, 117.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [156.0, 134.0, 158.0, 177.0, 140.0, 156.0, 157.0, 135.0, 172.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 165.0, 168.0, 164.0, 165.0, 168.0, 164.0, 171.0, 182.0], "unit": "score", "name": "audio-dft", "value": 167.6}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 76.0, 78.0, 76.0, 77.0, 141.0, 75.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [95.0, 104.0, 135.0, 95.0, 95.0, 94.0, 135.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [119.0, 120.0, 124.0, 119.0, 119.0, 120.0, 119.0, 121.0, 121.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 120.1}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 148.0, 148.0, 150.0, 147.0, 149.0, 148.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 98.0, 101.0, 97.0, 102.0, 98.0, 98.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 98.5}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 86.0, 85.0, 86.0, 85.0, 92.0, 92.0, 91.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [132.0, 122.0, 127.0, 130.0, 127.0, 132.0, 123.0, 143.0, 121.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [151.0, 147.0, 161.0, 149.0, 173.0, 159.0, 162.0, 157.0, 151.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.9}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 74.0, 72.0, 70.0, 72.0, 73.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1562.0000000000002}]} 06:00:20 INFO - Return code: 0 06:00:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:00:20 ERROR - # TBPL SUCCESS # 06:00:20 INFO - Running post-action listener: _resource_record_post_action 06:00:20 INFO - Running post-run listener: _resource_record_post_run 06:00:21 INFO - Total resource usage - Wall time: 1186s; CPU: 25.0%; Read bytes: 0; Write bytes: 536018944; Read time: 0; Write time: 617348 06:00:21 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 251621376; Read time: 0; Write time: 350144 06:00:21 INFO - run-tests - Wall time: 1170s; CPU: 25.0%; Read bytes: 0; Write bytes: 284135424; Read time: 0; Write time: 267204 06:00:21 INFO - Running post-run listener: _upload_blobber_files 06:00:21 INFO - Blob upload gear active. 06:00:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:00:21 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:00:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:22 INFO - (blobuploader) - INFO - Done attempting. 06:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:23 INFO - (blobuploader) - INFO - Done attempting. 06:00:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:23 INFO - Return code: 0 06:00:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:00:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc3d855bd2eb1d6c176f5f8f1b261d0c1cb758003b912fafcd46f5e1be7ee0a9f7b1b9806961f453812d69b3d0ac03eb57cf2595a823aadcfc1044db269768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1acfd9f30f4f849c05b00a9818b9576543ea346dd3e71e525296f49767d4b6e41a98d1cc1caf9a2884807704db06a9cf0667d6c4b68bb10a7e088495aaaba8"} 06:00:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:00:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:00:23 INFO - Contents: 06:00:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc3d855bd2eb1d6c176f5f8f1b261d0c1cb758003b912fafcd46f5e1be7ee0a9f7b1b9806961f453812d69b3d0ac03eb57cf2595a823aadcfc1044db269768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1acfd9f30f4f849c05b00a9818b9576543ea346dd3e71e525296f49767d4b6e41a98d1cc1caf9a2884807704db06a9cf0667d6c4b68bb10a7e088495aaaba8"} 06:00:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:23 INFO - Copying logs to upload dir... 06:00:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:00:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.461370 ========= master_lag: 0.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-05 06:00:23.460610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-05 06:00:23.464039) ========= 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc3d855bd2eb1d6c176f5f8f1b261d0c1cb758003b912fafcd46f5e1be7ee0a9f7b1b9806961f453812d69b3d0ac03eb57cf2595a823aadcfc1044db269768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1acfd9f30f4f849c05b00a9818b9576543ea346dd3e71e525296f49767d4b6e41a98d1cc1caf9a2884807704db06a9cf0667d6c4b68bb10a7e088495aaaba8"} build_url:https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005411 build_url: 'https://queue.taskcluster.net/v1/task/dF7Afxh_Rn2_k9wccNH2Xg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc3d855bd2eb1d6c176f5f8f1b261d0c1cb758003b912fafcd46f5e1be7ee0a9f7b1b9806961f453812d69b3d0ac03eb57cf2595a823aadcfc1044db269768", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1acfd9f30f4f849c05b00a9818b9576543ea346dd3e71e525296f49767d4b6e41a98d1cc1caf9a2884807704db06a9cf0667d6c4b68bb10a7e088495aaaba8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-05 06:00:23.478824) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 06:00:23.479349) ========= 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=fa44defc139c4ba8574fe040000001db-1457180095.933242-679670900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002098 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 06:00:23.525120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 06:00:23.525641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 06:00:23.525917) ========= ========= Total master_lag: 1.17 =========