builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1457537469.73 results: success (0) buildid: 20160309043048 builduid: 0127b56c37ab4ff9a64ba296d9c810af revision: 5143234fc6be8c842fa6ac7df75260fa7d43cfaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.733124) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.733595) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.733881) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004408 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.784632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.784922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.793618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.793885) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003221 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.840101) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.840420) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.840958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.841245) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 07:31:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-03-09 07:31:11 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.947259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.947569) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018791 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.998941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:09.999564) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5143234fc6be8c842fa6ac7df75260fa7d43cfaa --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5143234fc6be8c842fa6ac7df75260fa7d43cfaa --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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 07:31:11,118 truncating revision to first 12 chars 2016-03-09 07:31:11,118 Setting DEBUG logging. 2016-03-09 07:31:11,118 attempt 1/10 2016-03-09 07:31:11,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5143234fc6be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 07:31:11,807 unpacking tar archive at: mozilla-inbound-5143234fc6be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973866 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:10.986503) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:10.987192) ========= echo 5143234fc6be8c842fa6ac7df75260fa7d43cfaa in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5143234fc6be8c842fa6ac7df75260fa7d43cfaa'] 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5143234fc6be8c842fa6ac7df75260fa7d43cfaa program finished with exit code 0 elapsedTime=0.004713 script_repo_revision: '5143234fc6be8c842fa6ac7df75260fa7d43cfaa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:11.037755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:11.038051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 07:31:11.047459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-09 07:31:11.047726) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:31:12 INFO - MultiFileLogger online at 20160309 07:31:12 in /builds/slave/test-pgo 07:31:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:31:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:31:12 INFO - {'append_to_log': False, 07:31:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:31:12 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:31:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:31:12 INFO - 'branch': 'Mozilla-Inbound', 07:31:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:31:12 INFO - 'config_files': ('talos/linux_config.py',), 07:31:12 INFO - 'default_actions': ('clobber', 07:31:12 INFO - 'read-buildbot-config', 07:31:12 INFO - 'download-and-extract', 07:31:12 INFO - 'populate-webroot', 07:31:12 INFO - 'create-virtualenv', 07:31:12 INFO - 'install', 07:31:12 INFO - 'run-tests'), 07:31:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:31:12 INFO - 'download_minidump_stackwalk': True, 07:31:12 INFO - 'download_symbols': 'ondemand', 07:31:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:31:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:31:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:31:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:31:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:31:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:31:12 INFO - 'installer_path': 'installer.exe', 07:31:12 INFO - 'log_level': 'info', 07:31:12 INFO - 'log_name': 'talos', 07:31:12 INFO - 'log_to_console': True, 07:31:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:31:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:31:12 INFO - 'opt_config_files': (), 07:31:12 INFO - 'pip_index': False, 07:31:12 INFO - 'sps_profile': False, 07:31:12 INFO - 'sps_profile_interval': 0, 07:31:12 INFO - 'suite': 'dromaeojs', 07:31:12 INFO - 'system_bits': '32', 07:31:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:31:12 INFO - 'title': 'talos-linux64-ix-064', 07:31:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:31:12 INFO - 'use_talos_json': True, 07:31:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:31:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:31:12 INFO - 'work_dir': 'build'} 07:31:12 INFO - ##### 07:31:12 INFO - ##### Running clobber step. 07:31:12 INFO - ##### 07:31:12 INFO - Running pre-action listener: _resource_record_pre_action 07:31:12 INFO - Running main action method: clobber 07:31:12 INFO - rmtree: /builds/slave/test-pgo/build 07:31:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:31:12 INFO - Running post-action listener: _resource_record_post_action 07:31:12 INFO - ##### 07:31:12 INFO - ##### Running read-buildbot-config step. 07:31:12 INFO - ##### 07:31:12 INFO - Running pre-action listener: _resource_record_pre_action 07:31:12 INFO - Running main action method: read_buildbot_config 07:31:12 INFO - Using buildbot properties: 07:31:12 INFO - { 07:31:12 INFO - "project": "", 07:31:12 INFO - "product": "firefox", 07:31:12 INFO - "script_repo_revision": "production", 07:31:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:31:12 INFO - "repository": "", 07:31:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:31:12 INFO - "buildid": "20160309043048", 07:31:12 INFO - "pgo_build": "True", 07:31:12 INFO - "basedir": "/builds/slave/test-pgo", 07:31:12 INFO - "buildnumber": 754, 07:31:12 INFO - "slavename": "talos-linux64-ix-064", 07:31:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:31:12 INFO - "platform": "ubuntu64_hw", 07:31:12 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:31:12 INFO - "branch": "mozilla-inbound", 07:31:12 INFO - "repo_path": "integration/mozilla-inbound", 07:31:12 INFO - "revision": "5143234fc6be8c842fa6ac7df75260fa7d43cfaa", 07:31:12 INFO - "stage_platform": "linux64-pgo", 07:31:12 INFO - "builduid": "0127b56c37ab4ff9a64ba296d9c810af", 07:31:12 INFO - "slavebuilddir": "test" 07:31:12 INFO - } 07:31:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:31:12 INFO - Running post-action listener: _resource_record_post_action 07:31:12 INFO - ##### 07:31:12 INFO - ##### Running download-and-extract step. 07:31:12 INFO - ##### 07:31:12 INFO - Running pre-action listener: _resource_record_pre_action 07:31:12 INFO - Running main action method: download_and_extract 07:31:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:12 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:31:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:31:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:31:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:31:13 INFO - Downloaded 1361 bytes. 07:31:13 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:31:13 INFO - Using the following test package requirements: 07:31:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:31:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:31:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:31:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'jsshell-linux-x86_64.zip'], 07:31:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:31:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:31:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:31:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:31:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:31:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:31:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:31: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')]} 07:31:13 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:31:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:31:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:31:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:31:15 INFO - Downloaded 23405658 bytes. 07:31:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:31:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:31:16 INFO - Return code: 0 07:31:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:31: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')]} 07:31:16 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:31:17 INFO - Downloaded 23405658 bytes. 07:31:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:31:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:31:18 INFO - Return code: 0 07:31: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')]} 07:31:18 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:31:19 INFO - Downloaded 10845161 bytes. 07:31:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:31:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:31:19 INFO - Return code: 0 07:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:19 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:31:21 INFO - Downloaded 56211797 bytes. 07:31:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:31:21 INFO - mkdir: /builds/slave/test-pgo/properties 07:31:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:31:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:31:21 INFO - Contents: 07:31:21 INFO - build_url:https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:31:22 INFO - Running post-action listener: _resource_record_post_action 07:31:22 INFO - Running post-action listener: set_extra_try_arguments 07:31:22 INFO - ##### 07:31:22 INFO - ##### Running populate-webroot step. 07:31:22 INFO - ##### 07:31:22 INFO - Running pre-action listener: _resource_record_pre_action 07:31:22 INFO - Running main action method: populate_webroot 07:31:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:31:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:31:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:31:22 INFO - '--tppagecycles', 07:31:22 INFO - '7'], 07:31:22 INFO - 'tests': ['tsvgm']}}, 07:31:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:31:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:31:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:31:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:31:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'tests': ['damp', 'tps']}, 07:31:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['damp', 'tps']}, 07:31:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:31:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:31:22 INFO - 'other': {'tests': ['a11yr', 07:31:22 INFO - 'ts_paint', 07:31:22 INFO - 'tpaint', 07:31:22 INFO - 'sessionrestore', 07:31:22 INFO - 'sessionrestore_no_auto_restore', 07:31:22 INFO - 'tabpaint']}, 07:31:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['a11yr', 07:31:22 INFO - 'ts_paint', 07:31:22 INFO - 'tpaint', 07:31:22 INFO - 'sessionrestore', 07:31:22 INFO - 'sessionrestore_no_auto_restore', 07:31:22 INFO - 'tabpaint']}, 07:31:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['a11yr', 07:31:22 INFO - 'ts_paint', 07:31:22 INFO - 'tpaint', 07:31:22 INFO - 'sessionrestore', 07:31:22 INFO - 'sessionrestore_no_auto_restore', 07:31:22 INFO - 'tabpaint']}, 07:31:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['a11yr', 07:31:22 INFO - 'ts_paint', 07:31:22 INFO - 'tpaint', 07:31:22 INFO - 'sessionrestore', 07:31:22 INFO - 'sessionrestore_no_auto_restore', 07:31:22 INFO - 'tabpaint']}, 07:31:22 INFO - 'other_l64': {'tests': ['a11yr', 07:31:22 INFO - 'ts_paint', 07:31:22 INFO - 'tpaint', 07:31:22 INFO - 'sessionrestore', 07:31:22 INFO - 'sessionrestore_no_auto_restore', 07:31:22 INFO - 'tabpaint']}, 07:31:22 INFO - 'other_nol64': {'tests': ['a11yr', 07:31:22 INFO - 'ts_paint', 07:31:22 INFO - 'tpaint', 07:31:22 INFO - 'sessionrestore', 07:31:22 INFO - 'sessionrestore_no_auto_restore', 07:31:22 INFO - 'tabpaint']}, 07:31:22 INFO - 'svgr': {'tests': ['tsvgx', 07:31:22 INFO - 'tsvgr_opacity', 07:31:22 INFO - 'tart', 07:31:22 INFO - 'tscrollx', 07:31:22 INFO - 'cart']}, 07:31:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['tsvgx', 07:31:22 INFO - 'tsvgr_opacity', 07:31:22 INFO - 'tart', 07:31:22 INFO - 'tscrollx', 07:31:22 INFO - 'cart']}, 07:31:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'tests': ['tp5o']}, 07:31:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'talos_options': ['--e10s'], 07:31:22 INFO - 'tests': ['tp5o']}, 07:31:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'talos_options': ['--xperf_path', 07:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:22 INFO - 'tests': ['tp5n']}, 07:31:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:22 INFO - 'talos_options': ['--e10s', 07:31:22 INFO - '--xperf_path', 07:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:22 INFO - 'tests': ['tp5n']}}, 07:31:22 INFO - 'talos.zip': {'path': '', 07:31:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:31:22 INFO - Running post-action listener: _resource_record_post_action 07:31:22 INFO - ##### 07:31:22 INFO - ##### Running create-virtualenv step. 07:31:22 INFO - ##### 07:31:22 INFO - Running pre-action listener: _resource_record_pre_action 07:31:22 INFO - Running main action method: create_virtualenv 07:31:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:31:22 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 07:31:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:31:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:31:22 INFO - Using real prefix '/usr' 07:31:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:31:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:31:24 INFO - Installing pip.................done. 07:31:24 INFO - Return code: 0 07:31:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:31: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')]} 07:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:24 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:24 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 07:31:24 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 07:31:24 INFO - Using env: {'DISPLAY': ':0', 07:31:24 INFO - 'HOME': '/home/cltbld', 07:31:24 INFO - 'LANG': 'en_US.UTF-8', 07:31:24 INFO - 'LANGUAGE': 'en_US:en', 07:31:24 INFO - 'LOGNAME': 'cltbld', 07:31:24 INFO - 'MAIL': '/var/mail/cltbld', 07:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:24 INFO - 'MOZ_NO_REMOTE': '1', 07:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:24 INFO - 'NO_EM_RESTART': '1', 07:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:24 INFO - 'SHELL': '/bin/bash', 07:31:24 INFO - 'SHLVL': '1', 07:31:24 INFO - 'TERM': 'linux', 07:31:24 INFO - 'TMOUT': '86400', 07:31:24 INFO - 'USER': 'cltbld', 07:31:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:24 INFO - '_': '/tools/buildbot/bin/python'} 07:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:24 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 07:31:24 INFO - Cleaning up... 07:31:24 INFO - Return code: 0 07:31:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:31: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')]} 07:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:24 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:24 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 07:31:24 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 07:31:24 INFO - Using env: {'DISPLAY': ':0', 07:31:24 INFO - 'HOME': '/home/cltbld', 07:31:24 INFO - 'LANG': 'en_US.UTF-8', 07:31:24 INFO - 'LANGUAGE': 'en_US:en', 07:31:24 INFO - 'LOGNAME': 'cltbld', 07:31:24 INFO - 'MAIL': '/var/mail/cltbld', 07:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:24 INFO - 'MOZ_NO_REMOTE': '1', 07:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:24 INFO - 'NO_EM_RESTART': '1', 07:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:24 INFO - 'SHELL': '/bin/bash', 07:31:24 INFO - 'SHLVL': '1', 07:31:24 INFO - 'TERM': 'linux', 07:31:24 INFO - 'TMOUT': '86400', 07:31:24 INFO - 'USER': 'cltbld', 07:31:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:24 INFO - '_': '/tools/buildbot/bin/python'} 07:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:25 INFO - Downloading/unpacking psutil>=0.7.1 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:26 INFO - Installing collected packages: psutil 07:31:26 INFO - Running setup.py install for psutil 07:31:27 INFO - building 'psutil._psutil_linux' extension 07:31:27 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 07:31:27 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 07:31:27 INFO - building 'psutil._psutil_posix' extension 07:31:27 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 07:31:27 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 07:31:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:27 INFO - Successfully installed psutil 07:31:27 INFO - Cleaning up... 07:31:27 INFO - Return code: 0 07:31:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:31:27 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')]} 07:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:27 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')]} 07:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:27 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:27 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 07:31:27 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 07:31:27 INFO - Using env: {'DISPLAY': ':0', 07:31:27 INFO - 'HOME': '/home/cltbld', 07:31:27 INFO - 'LANG': 'en_US.UTF-8', 07:31:27 INFO - 'LANGUAGE': 'en_US:en', 07:31:27 INFO - 'LOGNAME': 'cltbld', 07:31:27 INFO - 'MAIL': '/var/mail/cltbld', 07:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:27 INFO - 'MOZ_NO_REMOTE': '1', 07:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:27 INFO - 'NO_EM_RESTART': '1', 07:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:27 INFO - 'SHELL': '/bin/bash', 07:31:27 INFO - 'SHLVL': '1', 07:31:27 INFO - 'TERM': 'linux', 07:31:27 INFO - 'TMOUT': '86400', 07:31:27 INFO - 'USER': 'cltbld', 07:31:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:27 INFO - '_': '/tools/buildbot/bin/python'} 07:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:31:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:31:29 INFO - Installing collected packages: mozsystemmonitor 07:31:29 INFO - Running setup.py install for mozsystemmonitor 07:31:29 INFO - Successfully installed mozsystemmonitor 07:31:29 INFO - Cleaning up... 07:31:29 INFO - Return code: 0 07:31:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:29 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:29 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 07:31:29 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 07:31:29 INFO - Using env: {'DISPLAY': ':0', 07:31:29 INFO - 'HOME': '/home/cltbld', 07:31:29 INFO - 'LANG': 'en_US.UTF-8', 07:31:29 INFO - 'LANGUAGE': 'en_US:en', 07:31:29 INFO - 'LOGNAME': 'cltbld', 07:31:29 INFO - 'MAIL': '/var/mail/cltbld', 07:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:29 INFO - 'MOZ_NO_REMOTE': '1', 07:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:29 INFO - 'NO_EM_RESTART': '1', 07:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:29 INFO - 'SHELL': '/bin/bash', 07:31:29 INFO - 'SHLVL': '1', 07:31:29 INFO - 'TERM': 'linux', 07:31:29 INFO - 'TMOUT': '86400', 07:31:29 INFO - 'USER': 'cltbld', 07:31:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:29 INFO - '_': '/tools/buildbot/bin/python'} 07:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:31:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:32 INFO - Downloading docopt-0.6.1.tar.gz 07:31:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:32 INFO - Running setup.py install for blobuploader 07:31:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:31:32 INFO - Running setup.py install for requests 07:31:33 INFO - Running setup.py install for docopt 07:31:33 INFO - Successfully installed blobuploader requests docopt 07:31:33 INFO - Cleaning up... 07:31:33 INFO - Return code: 0 07:31:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:33 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 07:31:33 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 07:31:33 INFO - Using env: {'DISPLAY': ':0', 07:31:33 INFO - 'HOME': '/home/cltbld', 07:31:33 INFO - 'LANG': 'en_US.UTF-8', 07:31:33 INFO - 'LANGUAGE': 'en_US:en', 07:31:33 INFO - 'LOGNAME': 'cltbld', 07:31:33 INFO - 'MAIL': '/var/mail/cltbld', 07:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:33 INFO - 'MOZ_NO_REMOTE': '1', 07:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:33 INFO - 'NO_EM_RESTART': '1', 07:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:33 INFO - 'SHELL': '/bin/bash', 07:31:33 INFO - 'SHLVL': '1', 07:31:33 INFO - 'TERM': 'linux', 07:31:33 INFO - 'TMOUT': '86400', 07:31:33 INFO - 'USER': 'cltbld', 07:31:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:33 INFO - '_': '/tools/buildbot/bin/python'} 07:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:31:33 INFO - Running setup.py (path:/tmp/pip-lVMjuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:31:33 INFO - Running setup.py (path:/tmp/pip-pfW2Bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:31:33 INFO - Running setup.py (path:/tmp/pip-Hmz7Pv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:31:33 INFO - Running setup.py (path:/tmp/pip-J7_A5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:31:33 INFO - Running setup.py (path:/tmp/pip-sCxjOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:31:33 INFO - Running setup.py (path:/tmp/pip-3hGivv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:31:33 INFO - Running setup.py (path:/tmp/pip-TTXWwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:31:33 INFO - Running setup.py (path:/tmp/pip-lNkhKb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:31:33 INFO - Running setup.py (path:/tmp/pip-fFcCrt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:31:34 INFO - Running setup.py (path:/tmp/pip-tZI2Vj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:31:34 INFO - Running setup.py (path:/tmp/pip-0mPelO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:31:34 INFO - Running setup.py (path:/tmp/pip-k3ZctH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:31:34 INFO - Running setup.py (path:/tmp/pip-1yvA07-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:31:34 INFO - Running setup.py (path:/tmp/pip-a3wBd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:31:34 INFO - Running setup.py (path:/tmp/pip-XbGkNH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:31:34 INFO - Running setup.py (path:/tmp/pip-7XfueC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:31:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:31:34 INFO - Running setup.py (path:/tmp/pip-Q4GGpA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:31:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:34 INFO - Running setup.py install for manifestparser 07:31:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:31:34 INFO - Running setup.py install for mozcrash 07:31:34 INFO - Running setup.py install for mozdebug 07:31:34 INFO - Running setup.py install for mozdevice 07:31:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Running setup.py install for mozfile 07:31:35 INFO - Running setup.py install for mozhttpd 07:31:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Running setup.py install for mozinfo 07:31:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Running setup.py install for mozInstall 07:31:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Running setup.py install for mozleak 07:31:35 INFO - Running setup.py install for mozlog 07:31:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Running setup.py install for moznetwork 07:31:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Running setup.py install for mozprocess 07:31:35 INFO - Running setup.py install for mozprofile 07:31:35 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:31:35 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:31:36 INFO - Running setup.py install for mozrunner 07:31:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:31:36 INFO - Running setup.py install for mozscreenshot 07:31:36 INFO - Running setup.py install for moztest 07:31:36 INFO - Running setup.py install for mozversion 07:31:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:31:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:36 INFO - Cleaning up... 07:31:36 INFO - Return code: 0 07:31:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:36 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:36 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 07:31:36 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 07:31:36 INFO - Using env: {'DISPLAY': ':0', 07:31:36 INFO - 'HOME': '/home/cltbld', 07:31:36 INFO - 'LANG': 'en_US.UTF-8', 07:31:36 INFO - 'LANGUAGE': 'en_US:en', 07:31:36 INFO - 'LOGNAME': 'cltbld', 07:31:36 INFO - 'MAIL': '/var/mail/cltbld', 07:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:36 INFO - 'MOZ_NO_REMOTE': '1', 07:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:36 INFO - 'NO_EM_RESTART': '1', 07:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:36 INFO - 'SHELL': '/bin/bash', 07:31:36 INFO - 'SHLVL': '1', 07:31:36 INFO - 'TERM': 'linux', 07:31:36 INFO - 'TMOUT': '86400', 07:31:36 INFO - 'USER': 'cltbld', 07:31:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:36 INFO - '_': '/tools/buildbot/bin/python'} 07:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:31:36 INFO - Running setup.py (path:/tmp/pip-ToQN_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:31:36 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)) 07:31:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:31:36 INFO - Running setup.py (path:/tmp/pip-lhodgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:31:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:31:36 INFO - Running setup.py (path:/tmp/pip-2jLYTZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:31:36 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)) 07:31:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:31:36 INFO - Running setup.py (path:/tmp/pip-per2ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:31:36 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)) 07:31:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:31:36 INFO - Running setup.py (path:/tmp/pip-xZDaR_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:31:37 INFO - Running setup.py (path:/tmp/pip-MLkVEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:31:37 INFO - Running setup.py (path:/tmp/pip-0t3HEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:31:37 INFO - Running setup.py (path:/tmp/pip-v3fGKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:31:37 INFO - Running setup.py (path:/tmp/pip-Zfu_NH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:31:37 INFO - Running setup.py (path:/tmp/pip-FvgdPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:31:37 INFO - Running setup.py (path:/tmp/pip-tPP7aY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:31:37 INFO - Running setup.py (path:/tmp/pip-LSXei8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:31:37 INFO - Running setup.py (path:/tmp/pip-v8Qbp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:31:37 INFO - Running setup.py (path:/tmp/pip-hbYYkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:31:37 INFO - Running setup.py (path:/tmp/pip-mgbq4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:31:37 INFO - Running setup.py (path:/tmp/pip-qGru0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:31:37 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)) 07:31:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:31:37 INFO - Running setup.py (path:/tmp/pip-cVNDoA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:31:37 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)) 07:31:37 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:37 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:37 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)) 07:31:37 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)) 07:31:37 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)) 07:31:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:37 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 07:31:37 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 07:31:37 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 07:31:37 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 07:31:37 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 07:31:37 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 07:31:39 INFO - Downloading blessings-1.6.tar.gz 07:31:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:39 INFO - Installing collected packages: blessings 07:31:39 INFO - Running setup.py install for blessings 07:31:39 INFO - Successfully installed blessings 07:31:39 INFO - Cleaning up... 07:31:39 INFO - Return code: 0 07:31:39 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:31:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:31:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:31:40 INFO - Reading from file tmpfile_stdout 07:31:40 INFO - Current package versions: 07:31:40 INFO - argparse == 1.2.1 07:31:40 INFO - blessings == 1.6 07:31:40 INFO - blobuploader == 1.2.4 07:31:40 INFO - docopt == 0.6.1 07:31:40 INFO - manifestparser == 1.1 07:31:40 INFO - mozInstall == 1.12 07:31:40 INFO - mozcrash == 0.17 07:31:40 INFO - mozdebug == 0.1 07:31:40 INFO - mozdevice == 0.48 07:31:40 INFO - mozfile == 1.2 07:31:40 INFO - mozhttpd == 0.7 07:31:40 INFO - mozinfo == 0.9 07:31:40 INFO - mozleak == 0.1 07:31:40 INFO - mozlog == 3.1 07:31:40 INFO - moznetwork == 0.27 07:31:40 INFO - mozprocess == 0.22 07:31:40 INFO - mozprofile == 0.28 07:31:40 INFO - mozrunner == 6.11 07:31:40 INFO - mozscreenshot == 0.1 07:31:40 INFO - mozsystemmonitor == 0.0 07:31:40 INFO - moztest == 0.7 07:31:40 INFO - mozversion == 1.4 07:31:40 INFO - psutil == 3.1.1 07:31:40 INFO - requests == 1.2.3 07:31:40 INFO - wsgiref == 0.1.2 07:31:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:31:40 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')]} 07:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:40 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')]} 07:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:40 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:40 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 07:31:40 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 07:31:40 INFO - Using env: {'DISPLAY': ':0', 07:31:40 INFO - 'HOME': '/home/cltbld', 07:31:40 INFO - 'LANG': 'en_US.UTF-8', 07:31:40 INFO - 'LANGUAGE': 'en_US:en', 07:31:40 INFO - 'LOGNAME': 'cltbld', 07:31:40 INFO - 'MAIL': '/var/mail/cltbld', 07:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:40 INFO - 'MOZ_NO_REMOTE': '1', 07:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:40 INFO - 'NO_EM_RESTART': '1', 07:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:40 INFO - 'SHELL': '/bin/bash', 07:31:40 INFO - 'SHLVL': '1', 07:31:40 INFO - 'TERM': 'linux', 07:31:40 INFO - 'TMOUT': '86400', 07:31:40 INFO - 'USER': 'cltbld', 07:31:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:40 INFO - '_': '/tools/buildbot/bin/python'} 07:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 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)) 07:31:40 INFO - Cleaning up... 07:31:40 INFO - Return code: 0 07:31:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:31:40 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')]} 07:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:40 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')]} 07:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:40 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 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:40 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 07:31:40 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 07:31:40 INFO - Using env: {'DISPLAY': ':0', 07:31:40 INFO - 'HOME': '/home/cltbld', 07:31:40 INFO - 'LANG': 'en_US.UTF-8', 07:31:40 INFO - 'LANGUAGE': 'en_US:en', 07:31:40 INFO - 'LOGNAME': 'cltbld', 07:31:40 INFO - 'MAIL': '/var/mail/cltbld', 07:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:40 INFO - 'MOZ_NO_REMOTE': '1', 07:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:40 INFO - 'NO_EM_RESTART': '1', 07:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:40 INFO - 'SHELL': '/bin/bash', 07:31:40 INFO - 'SHLVL': '1', 07:31:40 INFO - 'TERM': 'linux', 07:31:40 INFO - 'TMOUT': '86400', 07:31:40 INFO - 'USER': 'cltbld', 07:31:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:40 INFO - '_': '/tools/buildbot/bin/python'} 07:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:40 INFO - Downloading/unpacking jsonschema 07:31:40 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 07:31:40 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 07:31:40 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 07:31:40 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 07:31:40 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 07:31:40 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 07:31:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:42 INFO - Downloading/unpacking functools32 (from jsonschema) 07:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:42 INFO - warning: no files found matching '*.txt' 07:31:42 INFO - no previously-included directories found matching 'build' 07:31:42 INFO - no previously-included directories found matching 'dist' 07:31:42 INFO - no previously-included directories found matching '.git*' 07:31:42 INFO - Installing collected packages: jsonschema, functools32 07:31:42 INFO - Running setup.py install for functools32 07:31:42 INFO - warning: no files found matching '*.txt' 07:31:42 INFO - no previously-included directories found matching 'build' 07:31:42 INFO - no previously-included directories found matching 'dist' 07:31:42 INFO - no previously-included directories found matching '.git*' 07:31:42 INFO - Successfully installed jsonschema functools32 07:31:42 INFO - Cleaning up... 07:31:42 INFO - Return code: 0 07:31:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfa03ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', '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 07:31:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:31:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:31:42 INFO - Using env: {'DISPLAY': ':0', 07:31:42 INFO - 'HOME': '/home/cltbld', 07:31:42 INFO - 'LANG': 'en_US.UTF-8', 07:31:42 INFO - 'LANGUAGE': 'en_US:en', 07:31:42 INFO - 'LOGNAME': 'cltbld', 07:31:42 INFO - 'MAIL': '/var/mail/cltbld', 07:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:42 INFO - 'MOZ_NO_REMOTE': '1', 07:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:42 INFO - 'NO_EM_RESTART': '1', 07:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:31:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:31:42 INFO - 'SHELL': '/bin/bash', 07:31:42 INFO - 'SHLVL': '1', 07:31:42 INFO - 'TERM': 'linux', 07:31:42 INFO - 'TMOUT': '86400', 07:31:42 INFO - 'USER': 'cltbld', 07:31:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:42 INFO - '_': '/tools/buildbot/bin/python'} 07:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:43 INFO - Downloading/unpacking flake8 07:31:43 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 07:31:43 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 07:31:43 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 07:31:43 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 07:31:43 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 07:31:43 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 07:31:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:31:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:31:44 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 07:31:44 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 07:31:44 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 07:31:44 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 07:31:44 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 07:31:44 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 07:31:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:31:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:31:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:31:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:31:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:31:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:31:45 INFO - no previously-included directories found matching 'docs/_build' 07:31:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:31:45 INFO - Running setup.py install for pep8 07:31:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:31:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:31:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:31:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:31:45 INFO - no previously-included directories found matching 'docs/_build' 07:31:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:31:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:31:45 INFO - Cleaning up... 07:31:45 INFO - Return code: 0 07:31:45 INFO - Running post-action listener: _resource_record_post_action 07:31:45 INFO - Running post-action listener: _start_resource_monitoring 07:31:45 INFO - Starting resource monitoring. 07:31:45 INFO - ##### 07:31:45 INFO - ##### Running install step. 07:31:45 INFO - ##### 07:31:45 INFO - Running pre-action listener: _resource_record_pre_action 07:31:45 INFO - Running main action method: install 07:31:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:31:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:31:46 INFO - Reading from file tmpfile_stdout 07:31:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:31:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:31:46 INFO - Reading from file tmpfile_stdout 07:31:46 INFO - Output received: 07:31:46 INFO - Usage: mozinstall [options] installer 07:31:46 INFO - Options: 07:31:46 INFO - -h, --help show this help message and exit 07:31:46 INFO - -d DEST, --destination=DEST 07:31:46 INFO - Directory to install application into. [default: 07:31:46 INFO - "/builds/slave/test-pgo"] 07:31:46 INFO - --app=APP Application being installed. [default: firefox] 07:31:46 INFO - mkdir: /builds/slave/test-pgo/build/application 07:31:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:31:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:32:02 INFO - Reading from file tmpfile_stdout 07:32:02 INFO - Output received: 07:32:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:32:02 INFO - Running post-action listener: _resource_record_post_action 07:32:02 INFO - ##### 07:32:02 INFO - ##### Running run-tests step. 07:32:02 INFO - ##### 07:32:02 INFO - Running pre-action listener: _resource_record_pre_action 07:32:02 INFO - Running main action method: run_tests 07:32:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:32:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:32:02 INFO - Python 2.7.3 07:32:02 INFO - Return code: 0 07:32:02 INFO - grabbing minidump binary from tooltool 07:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:02 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 0x22db920>, '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 0x22dc820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dccb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:32:02 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 07:32:02 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 07:32:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:32:02 INFO - Return code: 0 07:32:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:32:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:32:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:32:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:32:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:32:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:32:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:32:03 INFO - Return code: 0 07:32:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:32:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:32:03 INFO - Using env: {'DISPLAY': ':0', 07:32:03 INFO - 'HOME': '/home/cltbld', 07:32:03 INFO - 'LANG': 'en_US.UTF-8', 07:32:03 INFO - 'LANGUAGE': 'en_US:en', 07:32:03 INFO - 'LOGNAME': 'cltbld', 07:32:03 INFO - 'MAIL': '/var/mail/cltbld', 07:32:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:32:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:03 INFO - 'MOZ_NO_REMOTE': '1', 07:32:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:03 INFO - 'NO_EM_RESTART': '1', 07:32:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:32:03 INFO - 'SHELL': '/bin/bash', 07:32:03 INFO - 'SHLVL': '1', 07:32:03 INFO - 'TERM': 'linux', 07:32:03 INFO - 'TMOUT': '86400', 07:32:03 INFO - 'USER': 'cltbld', 07:32:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853', 07:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:03 INFO - '_': '/tools/buildbot/bin/python'} 07:32:03 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:32:03 INFO - mozversion application_buildid: 20160309043048 07:32:03 INFO - mozversion application_changeset: 5143234fc6be8c842fa6ac7df75260fa7d43cfaa 07:32:03 INFO - mozversion application_display_name: Nightly 07:32:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:32:03 INFO - mozversion application_name: Firefox 07:32:03 INFO - mozversion application_remotingname: firefox 07:32:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:32:03 INFO - mozversion application_vendor: Mozilla 07:32:03 INFO - mozversion application_version: 48.0a1 07:32:03 INFO - mozversion platform_buildid: 20160309043048 07:32:03 INFO - mozversion platform_changeset: 5143234fc6be8c842fa6ac7df75260fa7d43cfaa 07:32:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:32:03 INFO - mozversion platform_version: 48.0a1 07:32:03 INFO - using testdate: 1457537523 07:32:03 INFO - actual date: 1457537523 07:32:03 INFO - starting webserver on 'localhost:44262' 07:32:03 INFO - SUITE-START | Running 2 tests 07:32:03 INFO - TEST-START | dromaeo_css 07:32:03 INFO - operating with platform_type : linux_ 07:32:03 INFO - Initialising browser for dromaeo_css test... 07:32:03 INFO - TEST-INFO | started process 25038 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6u1kPN/profile http://localhost:44262/getInfo.html) 07:32:08 INFO - PROCESS | 25038 | __metrics Screen width/height:1600/1200 07:32:08 INFO - PROCESS | 25038 | colorDepth:24 07:32:08 INFO - PROCESS | 25038 | Browser inner width/height: 1024/697 07:32:08 INFO - PROCESS | 25038 | __metrics 07:32:09 ERROR - PROCESS | 25038 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:32:10 INFO - TEST-INFO | 25038: exit 0 07:32:10 INFO - Browser initialized. 07:32:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:32:10 INFO - TEST-INFO | started process 25130 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6u1kPN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:22 INFO - PROCESS | 25130 | RSS: Main: 155320320 07:32:22 INFO - PROCESS | 25130 | 07:33:13 INFO - PROCESS | 25130 | 1457537593673 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] 07:35:21 INFO - PROCESS | 25130 | Cycle 1(1): loaded http://localhost:44262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44262/tests/dromaeo/cssquery-ext.html) 07:35:22 INFO - PROCESS | 25130 | RSS: Main: 259448832 07:35:22 INFO - PROCESS | 25130 | 07:38:25 INFO - PROCESS | 25130 | Cycle 1(1): loaded http://localhost:44262/tests/dromaeo/cssquery-ext.html (next: http://localhost:44262/tests/dromaeo/cssquery-jquery.html) 07:38:25 INFO - PROCESS | 25130 | RSS: Main: 243019776 07:38:25 INFO - PROCESS | 25130 | 07:41:28 INFO - PROCESS | 25130 | Cycle 1(1): loaded http://localhost:44262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44262/tests/dromaeo/cssquery-mootools.html) 07:41:29 INFO - PROCESS | 25130 | RSS: Main: 192946176 07:41:29 INFO - PROCESS | 25130 | 07:44:31 INFO - PROCESS | 25130 | Cycle 1(1): loaded http://localhost:44262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44262/tests/dromaeo/cssquery-prototype.html) 07:44:31 INFO - PROCESS | 25130 | RSS: Main: 230948864 07:44:31 INFO - PROCESS | 25130 | 07:47:34 INFO - PROCESS | 25130 | Cycle 1(1): loaded http://localhost:44262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44262/tests/dromaeo/cssquery-yui.html) 07:47:34 INFO - PROCESS | 25130 | RSS: Main: 187871232 07:47:34 INFO - PROCESS | 25130 | 07:50:37 INFO - PROCESS | 25130 | Cycle 1(1): loaded http://localhost:44262/tests/dromaeo/cssquery-yui.html (next: http://localhost:44262/tests/dromaeo/cssquery-dojo.html) 07:50:38 INFO - PROCESS | 25130 | RSS: Main: 777338880 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | __start_tp_report 07:50:38 INFO - PROCESS | 25130 | _x_x_mozilla_page_load 07:50:38 INFO - PROCESS | 25130 | _x_x_mozilla_page_load_details 07:50:38 INFO - PROCESS | 25130 | |i|pagename|runs| 07:50:38 INFO - PROCESS | 25130 | |0;dojo.html;3137.780355375122;3176.825274609896;3227.4997375406806;3239.7894136881114;3259.7555183361255;5077.79688812448;5152.768125434355;5153.458886816887;5201.453847346031;5260.947390526098;5164.070467315891;5185.714785686786;5194.584433245341;5217.217417387394;5259.973700131494;4687.226607609758;4756.738379389141;4808.08646357191;4815.0610630926985;4835.516448355172;4645.651576131803;4718.174319494092;4753.928691069636;4764.714117152982;4889.755512224392;4744.122337367598;4747.382840230783;4761.023990082025;4775.116603428377;4785.497522760113;4728.976355118237;4745.976270118662;4748.240281554935;4768;4772.451168115676;4627.884302892421;4698.060387922429;4752.334673145762;4762;4789.952100478986;5053.343065401511;5070.594352451795;5070.873228169288;5098.974505127488;5106.923396149061;5555.749991250363;5558.082916318803;5559.861003474945;5569.359523654751;5613.663180209201;5485.6982865942355;5580.051391263495;5621.4659607337235;5653.23681303027;5658.34928983164;5190.06578815813;5193.584513238932;5198.142306519419;5200.999999999962;5243.082460569423;5637.379888212294;5638.04153293941;5639.266895303666;5643.746031428514;5643.802466913638;5314.946850531523;5448.182772584065;5452.509274165344;5488.368837583729;5546.58400619947;5529.253550770675;5565.916511252334;5566.6381685191145;5566.693831839288;5569.220309156722;5537.335519737658;5537.363203231599;5542.889142217133;5543.8891222176135;5590.273264475673;5366.6243362964215;5537.086380747212;5580.2466666999435;5610.915836262459;5636.633618814764;4247.766372849461;4262.744235345889;4263.040815816478;4263.616274535307;4295.033617436052;3740.588535261119;3837.5586807516934;3845.9038524036564;3869.6517313441927;3889.649931506178;5102.2346648003095;5148.30497882781;5150.510701483353;5163.173892177234;5203.661761985459;5535.142052981794;5565.526930210896;5577.330720313588;5579.832605021856;5594.86012849682;5062.215356619657;5164.509371609691;5204.167333226741;5205.635605507654;5236.554892834151;4748.121597504472;4772.451168115711;4778.832740854054;4790.928136077961;4809.879753006203;5837.387074357216;5876.882462350729;5877.764889404376;5882.911756323744;5927.525797936155;5399.325084364455;5528.889422211453;5601.243832082617;5607.327120745536;5617.4101719320515;5860.062390017577;5868.2664666916635;5877.500412464989;5878.088896221093;5882.852928676817;5514.310711161105;5538.667679939216;5541;5541.556675466034;5563.888722225452;5461.15352120422;5541.584381171348;5571.637843540157;5592.496675299242;5617.241672374177;5413.377461591967;5420.83737487876;5431.23962645222;5442.37412697529;5453.945460545344;5403.13549832025;5446.754896029609;5449.891002180014;5454.945450545602;5455.672659640434;5178.61160412963;5310.256564081109;5362.088444964444;5377.569794416359;5425.159100339453;5475.288212532505;5481.945180548143;5485.61600687964;5492.697901615449;5495.890082198413;5198.350206224222;5329.520343169133;5379.569634429315;5385.6230063895155;5392.379876314274 07:50:38 INFO - PROCESS | 25130 | |1;ext.html;535.6357676779788;548.7859734703467;597.0298265318856;600.3066458240733;608.4523928464381;28497.85751071244;29358.853205733994;29361.265968350774;29385.853070734618;29468.263293417676;40219.39670904932;40653.7967310163;40695.186096278056;40700.592994070124;40756.18487630245;8522.33814406191;8733.563321833915;8736.650533978633;8740.082291359411;8741.825163496726;8558.743237702878;8685.218330350268;8687.652493900268;8691.60887760049;8691.782705432382;8619.741407757778;8699.652013919467;8705.738827835175;8712.259457946082;8712.259457946082;8582.957085214564;8659.696910608161;8660.263877570382;8664.48013119215;8705.7823554411;8509.489430634181;8608.870866937;8629.223369896677;8629.784255393666;8632.093630168805;40976.79511602453;41371.586284137076;41371.586284137076;41430.792846035576;41434.37848432276;3033.5752994580776;3055.5569442430947;3057.785954983152;3061.3112049788842;3185.2355434695737;30025.399492010038;30306.84846575775;30713;30730.539041914388;30788.384232315453;3851.903702407434;3877.4377715231135;3881.71254371918;3883.184531248441;3980.5223373195404;267397;269122;269146;269186;269806.65096674586;56806.147907781415;56838.43161568414;57159.428405716244;57209.71395143081;57254;60183.39816601778;60223.39776602178;60255.397446025854;60464;60504.39495605075;14992.70014599702;15177.089374637557;15192.164430956404;15207.31567079484;15217.467388641344;12005.91946724799;12147.210431321935;12147.271163730204;12150.939245303716;12155.453004614814;18053.819461805477;18439;18604.906975465037;18618.06909654539;18690.158942847604;7350.4119670426235;7492.325690687864;7588.658510367047;7660.885086723703;7678.884816727754;817.1379194949385;845.9830803384021;954.5179684259405;979.1628157925014;986.0386123529502;26975.325616859736;27726.445471090465;28636.85681571579;28723;30961.845190773904;956.6030097509456;998.6554638649654;1013.2856336282903;1073.1951036722458;1082.4966390628394;12030.578929737418;14944.402223910922;15817.209139542976;16301.755473667905;16566.585835354213;249666;253213;253355;254339;450342;42832;43212.56787432148;50896.74551627218;52820.20769688381;52861.47138528642;1265.3926115464628;1363.0867318896362;1368.3158420789605;1372.8901687864948;1483.3547406878042;25098.62352064684;25141.622875656514;25174.24477265685;25196.49607007886;25667.97328106855;39299.2140157201;39815.402768959066;39891.60108398879;39929;39961.80019099886;242974;279364;316114;317562;321078;29031.7096829029;29051.709482905746;29227.85386073141;29475.852620736758;29486.852565737892;37818.24363512769;37981.430278546395;38001.80999094987;38035.42946855744;38056.238875222894;23663.52672946497;31211.843940780152;31532.36935261236;34368.14079647929;35363.46954795731;32935;33195;34854.47718284177;36393;37158.628413715516;33502.162445939044;35154.296914061066;35444.291114178086;35454.822725887236;35478.29043419169;27764.722352777022;29573.556396654498;29745.70254297516;33269.83365083159;33488;21178;21434.6784798225;25555.744442555337;25927.22218333453;26471.33821654474 07:50:38 INFO - PROCESS | 25130 | |2;jquery.html;355.7527518374729;356.4225953954594;365.528468275924;369.8686966127023;371.01495529369515;16497.42259020933;16829.41097061603;17379.044152571605;18254.17856196471;18269;15577.844221557782;15964.28160732767;15979.440719574817;16014.519564413085;16198;5348.91976620351;5476.7535460904155;5479.123340265558;5509.614326997112;5510.724463776815;5433.429489903562;5474.42518535554;5477.698726570037;5478.561715062805;5479.369872464657;5434.673919564819;5445.428230035848;5449.809256676017;5452.182172674091;5454.699991500466;5395.541378982791;5410.513053825155;5435.374931882845;5442.2380866678495;5451.918221226685;3614.4759009943673;3657.579378371495;3773.641504057138;3779.8866034019024;3781.7730936143644;19321.710174347398;19355.90322048395;19932;19941.202351905908;19955.800441995685;2127.319257837493;2165.8375621828427;2180.269609680743;2199.846010779246;2253.0649780341137;9190.816183676356;9609.327347085708;9671;9719.951400242953;12600.558980435733;1724.2930398536664;1786.696261635512;1855.9536011599819;1867.3557622620174;1995.1520603743352;59561;62743;63021.369786302006;63456.365436345506;67307;9579.952100239454;9727.270454715925;10209;10295.742606434898;10388.272820902615;13768.862311376757;13824.308784560732;13908.652283692787;13914.721705565831;13948.58154255374;7269.63651817407;7347.228541003225;7375.631218439056;7621.580813055335;7623.656935437919;6947.131608548932;7137.785866424016;7155.499115062;7174.210836807947;7219.0976127984;4662.906741865144;4739.644526660445;4741.170295198395;4803.567678908845;4808.927866082012;1851.6111616560404;1857.5913299074182;1891.7635295588052;1897.5635603811202;1931.7102434634637;829.9626516806758;859.0207163833235;940.1867384712175;1045.3153184664056;1088.3905013192636;16321.591960200853;16613.833861661227;16983.150842457828;17582.560435988948;18023.098845057695;908.6955869783565;938.2915898496591;939.0093451408693;988.4415305352453;1080.4111759091313;8954.328425368123;9935.254855885838;10076;10151.340162889388;10378.688639340831;401990;405098;416405;420048;424247;55644.16533751916;71826.64086679534;71834.64082679553;72015.2798472019;72063;874.7157173918501;909.6725178935578;987.1559816357055;988.5057471264367;991.2813210422386;10714.269142069887;14965.952383333062;15054.397824086915;15151.924240378728;15331.77002344988;26778.330541736614;27796.722032779413;33964;34917.30165396627;34945.65054349424;32928.67071329256;33069.17327066843;33078.17304567405;33098;33103.50344744879;6460.25707043696;6564;6567.802965911031;6571.605703657796;6579.572327798678;5374.707259953223;7298.744543940937;7366.96316518414;7377.8155546111775;7382.335589796944;8565.100664430394;8581.570921454027;8582.184692454206;8593.097724738813;8640.438371505832;6932.896006560007;10291.33106348085;11222.214444988773;11384.658460246206;11417.657470275904;10449;10455.634052808115;10474.109700675528;10474.319169253975;10644.520996555018;7680.308772210527;7753.844923101619;7818.687252509836;8014.318782903519;8186.09952905168;6101.5118790497545;8374.2881855043;8412.915870841212;8419.8737018946;8425.157484251526 07:50:38 INFO - PROCESS | 25130 | |3;mootools.html;1278.6867217531703;1352.9255890925995;1410.6755446247362;1420.6661434562875;1823.4073925974053;7727.99536060312;7935.92064079359;7949;7954.562499062549;7955.960220198898;7762.650680719367;7767.145613982458;7770.494917830351;7770.728024519143;7794.8441031179345;2016.3850025742142;2055.0649454498166;2272.8181745460324;2301.6892719482908;2324.3027091872373;2317.351141680332;2318.6174281243575;2320.443093657527;2321.94195145121;2323.488832456857;2225.810806081485;2276.804677544286;2290.1526435218993;2290.290010096867;2290.9656355154684;2237.1275202671054;2264.8074913632363;2266.6939963104933;2278.646809744476;2305.896234669444;2259.9548009039727;2274.397284719534;2293.896774645145;2298.092253559851;2298.528801595669;7917.485363451415;7971.561564113971;7972.20277972204;7977.760667179994;7985.321247693953;4703.482616912137;4788.569028787426;4793.3768610080815;4819.0602832447685;4824.107540105092;2992.2369795702175;3098.2409309719037;3111.6577176510564;3144.166795799115;3145.6697046810214;975.7511834482233;1002.0380434782618;1009.8636684047633;1010.8129995950699;1044.2011860926398;11096.833547496793;11123.721906952229;11183.440827958651;11185.552577896875;11186.944065279622;3981.5421226558738;4074.2258970795456;4089.8364065437645;4112.321466957978;4206.957930420718;8636.481811091355;8677.175668311627;8720.258778003814;8728.563571821383;8735.868961965576;4753.762311884392;4756.096341695136;4758.072175925661;4761.4524329701835;4779.402574678165;3887.5723670396233;4243.872683819491;4301.3117901135665;4330.069035157393;4333.8699839004885;3459.930801383958;3506.3513250048823;3532.0993146747414;3559.839807208682;3573.9821300893327;1047.9685609431729;1051.3796859852723;1051.994740026295;1058.317385286486;1059.1950117910444;1047.4134484688598;1067.690369792767;1067.765091679829;1249.5251804314485;1394.902356835012;7359.521631094069;7479.962600186965;7803.921960780433;7809.687612495437;7869.213078692085;457.5310306935351;464.41251816452217;483.48750324655975;488.131126594655;489.9828506002344;5978.850528736816;5985.431384018511;5986.102084687332;5986.850328741816;6080.209572755602;9355.859662105075;9805.117539421486;9930.851037234448;9943.950280248697;9989.600415983425;9755.853662195073;9788.951055244679;9802.215822734164;9823.214142868554;9828.164606008426;7454.664540095709;7683.154852966281;7764.767056988299;7767.18444563324;7770.14528401864;7369.226231245856;7479.850402991801;7486.326230639269;7486.625668716433;7492.850142997;8614.78463038429;8657;8679.86980195285;8700.347473939353;8910.732678019669;8729.345299102719;8895.955520222617;9013.414128081917;9041.864372034293;9077.727668169966;6098.512119030378;6239.251289845066;6330.177076979963;6858.971154326891;7006.579605223703;7559.584222867795;7591.734289299848;7616.504927179715;7636.427267954815;7638;6774.390304872585;7085.220625731063;7147.035150254649;7158.570485770871;7166.283371662792;6848.14398200225;6910.619915904473;7070.328318809705;7106.040684507525;7144.428445724434;7159.140903091662;7178;7183.784486465414;7196.424286056998;7215.314545118205;6666.566673166229;6700.597964122168;6715.630640314829;6718;6722.865542689021;6529.836754080996;6680.899786503109;6734.057231987427;6744.595324280559;6752.358525940224 07:50:38 INFO - PROCESS | 25130 | |4;prototype.html;329.05396983671943;330.73871641403287;341.56279961649096;342.3239102772024;344.5951007566111;5806.332271788746;5821.621594596349;5823.272090988627;5850.268716410449;5861.882762344761;5769.7692092316365;5778;5779.162021506879;5788.04497257953;5799.9130013049835;4341.544137865526;4437.5562443755525;4517.887052823673;4568.154891345095;4573.954260457386;4523.185826551219;4558.088382323532;4567.8172873085205;4571.748553829538;4572.634189264851;4322.200392927302;4538.773061346936;4547.045120524694;4550.340200670901;4557.179707652621;4413.426254586915;4512.7743612819395;4522.660800439948;4524.276115821485;4547.431571053618;4001.3197756381487;4001.9399709004388;4009.037830920587;4014.116894283253;4017.598240175959;5551.777928882881;5553.139263414178;5553.278073850414;5560.749766260528;5567.359753628344;5242.344706911636;5246.501582349709;5248.343957005374;5251.474852514756;5253.605979551549;6129.080637904305;6134.325224225332;6144.938550614482;6145.139680444741;6150.04674275488;4181.686373521968;4297.140571885604;4299.527052024275;4300.548442413564;4419.18245124653;6272.1219029335925;6324.810255692337;6333.20834895638;6352.714127864211;6362.2365316161895;4391.560843915583;4391.934120988188;4393.802278897458;4397.2304846651705;4398.494173170063;4452.910941781146;4456.888577785581;4458.71018383804;4459.308807134835;4459.866204013885;5131.846044618667;5136.203888397305;5140.845774626767;5144.0997825381155;5146.996335714574;6146.477549408351;6147.0779383092895;6150.646857691301;6159.6612186329285;6163.414475624809;1557.8208506021726;1579.7314456542415;1581.533447632951;1583.4932821497011;1584.0179088964915;955.3074021334477;991.3605724307926;1046.2989796836139;1051.316644181273;1067.290251982423;5790.639199788046;5802.4197580241635;5833.562482813806;5841.1238314253205;5844.444777746107;6256.843578910563;6258.655773932386;6258.718357673915;6258.906116408258;6269.059641053878;5829.329627092939;5831.096180092092;5831.79588714393;5838.065909454467;5842.094475356326;3323.9501407478906;3344.9665503344654;3363.8654453822064;3365.6129545102626;3378.442556978071;6472;6543.378379053982;6563.638999855054;6702.597844129368;6706.362895524917;6468.06213099098;6475.676216189172;6507.739690412331;6509;6512.316206798313;6691.996200569856;6692.564983276169;6694.765683201064;6697.330266973361;6702.631355275409;6352.110704501466;6356.110144579855;6360.332165122595;6360.363963603602;6364.777232797015;6286.339934307015;6298.212723409574;6298.842528936813;6298.937010630018;6310.05349197624;6517.395040265463;6576.539642224999;6673;6680.098186744727;6688.431483323778;4375.562443755599;4377.146456441091;4401.82392704301;4411.580899814641;4419.558044195684;6094.11635312886;6341.175647165839;6369.840753981002;6383.1382763326355;6389.2971773105855;6036.456718895321;6175.042868355412;6216.658083805253;6217.595856269328;6228.065790131516;6165.660888651168;6179.752809887734;6180.505559555315;6186.5360097993735;6201.379862013943;6067.908981365194;6073.908891366721;6074.544409169242;6077;6083.330833608388;6192.969035154795;6228.346023667631;6230.563860529901;6233.625982441068;6245.5628106033955;5890.734916928663;6061.545384096122;6098.146259523582;6123.14276001369;6124.816255512342 07:50:38 INFO - PROCESS | 25130 | |5;yui.html;746.2574738135556;750.4184257200669;758.5069704691949;761.1855314813153;773.1302284929454;12774.936125319373;12907.935460322686;12967.935160324198;12972;12976.610701678941;12746.171498852567;13934.930325348385;14156.78764818526;14182.503612373568;14188.361523731432;541.066660011481;541.8455740114068;542.0568211312318;547.7808876449412;691.0360047733409;835.7910522369408;844.5228445928032;848.6944699908029;849.9702510412137;850.4727069217095;889.7908991387019;891.3893982621893;893.3523195683143;897.8698088777123;898.371140201858;720.8197950512372;886.3042511628373;886.5700135434341;886.8049029213595;894.4365050018512;648.2965981909633;650.7494614573376;652.5953908576665;652.7030201258416;652.7552167937024;13602.115862468909;13602.251876146807;13602.727945441135;13614.455421783117;13630.522931697442;12588.559400420942;12595.173699813477;12985.545505907343;13151.21092734439;13330.266835324053;9973.601055957753;10241.795164096677;10857.34855908648;10962.397068161248;11104.333739975627;3521.7358698097746;3532.6114127445962;3639.3813051781262;3710.9814450927843;3713.2016616427327;49853.75073124611;51015.744921275524;51022.7448862757;51058.489415106116;51065;9512.429254244767;9780.706578802647;10038.64864729731;10180.592776289013;10739.570417183382;17836.46490605284;17839.286428542713;18184.27262909469;18369.173387197607;18413.26346946134;7549.811254718676;7783;7784.221577842283;7896.763097107096;8047.879281810778;4109.137081212919;4207.894802629959;4284.036091879365;4299.914001719948;4349.934750978738;2965.8813647453862;2978.1214541710247;2983.880644774228;2992.895248666286;3005.609270794783;557.9748911299001;563.630821811714;566.1620801214226;566.1762136091976;566.5524235853712;648.5071345777243;650.2164891305965;653.1933062667601;665.128681427322;686.9965650171717;7862.488938218998;8301.543415112106;8494.660213591387;8767;9405.059494050676;603.7313395539031;620.7020630097578;658.6838317607575;672.2135101930753;672.4821887146869;3776.981115094407;3787.280416720814;3885.2812229737588;3980.20395920817;4194.972231803166;51511;53990.46009539933;54354;54376.728116359955;54466.18300725492;45833.77083114563;47602.76198618985;47707.52292477031;47926.520734792204;48031.035499853024;43156.78421607872;44953;45485.54514454879;45761.542384576394;45834.54165458303;7431.628418578941;7764.92235077642;7771.1840256774485;7777.066751989797;7785.64964576584;33350.833245833615;33741.325173495905;34706.30587388187;34732.13169670779;35142.29715405728;37385.62614373821;38697;39521.02394880302;39597.80201098976;39610;6977.686004129725;10492.475376231005;10609.522571484147;10620.362778233331;10622;8831.91168088311;10865.619703310662;10948.124150068135;11327.263727857662;11588.246763960316;9660.37207581505;10882.61910833117;11419.486123124314;11530.94234528822;12015.579454719043;11607.071434285406;11944;12072.637820865388;12100.394980251129;12180.878191217975;11114.722131946766;11333.366489282274;11457.541698332307;11530.94234528822;11928.522859085539;9031.36780425364;9032.187103160748;9101.317401195069;9504.334696571173;9525.952370238105;8459.667227780508;8555.657773688983;8638.82722345537;9400.576974036048;9669.758256043655 07:50:38 INFO - PROCESS | 25130 | __end_tp_report 07:50:38 INFO - PROCESS | 25130 | __start_cc_report 07:50:38 INFO - PROCESS | 25130 | _x_x_mozilla_cycle_collect,1171 07:50:38 INFO - PROCESS | 25130 | __end_cc_report 07:50:38 INFO - PROCESS | 25130 | __startTimestamp1457538638021__endTimestamp 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | ------- Summary: start ------- 07:50:38 INFO - PROCESS | 25130 | Number of tests: 6 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | [#0] dojo.html Cycles:165 Average:5174.95 Median:5377.57 stddev:566.07 (10.5%) stddev-sans-first:544.78 07:50:38 INFO - PROCESS | 25130 | Values: 3137.8 3176.8 3227.5 3239.8 3259.8 5077.8 5152.8 5153.5 5201.5 5260.9 5164.1 5185.7 5194.6 5217.2 5260.0 4687.2 4756.7 4808.1 4815.1 4835.5 4645.7 4718.2 4753.9 4764.7 4889.8 4744.1 4747.4 4761.0 4775.1 4785.5 4729.0 4746.0 4748.2 4768.0 4772.5 4627.9 4698.1 4752.3 4762.0 4790.0 5053.3 5070.6 5070.9 5099.0 5106.9 5555.7 5558.1 5559.9 5569.4 5613.7 5485.7 5580.1 5621.5 5653.2 5658.3 5190.1 5193.6 5198.1 5201.0 5243.1 5637.4 5638.0 5639.3 5643.7 5643.8 5314.9 5448.2 5452.5 5488.4 5546.6 5529.3 5565.9 5566.6 5566.7 5569.2 5537.3 5537.4 5542.9 5543.9 5590.3 5366.6 5537.1 5580.2 5610.9 5636.6 4247.8 4262.7 4263.0 4263.6 4295.0 3740.6 3837.6 3845.9 3869.7 3889.6 5102.2 5148.3 5150.5 5163.2 5203.7 5535.1 5565.5 5577.3 5579.8 5594.9 5062.2 5164.5 5204.2 5205.6 5236.6 4748.1 4772.5 4778.8 4790.9 4809.9 5837.4 5876.9 5877.8 5882.9 5927.5 5399.3 5528.9 5601.2 5607.3 5617.4 5860.1 5868.3 5877.5 5878.1 5882.9 5514.3 5538.7 5541.0 5541.6 5563.9 5461.2 5541.6 5571.6 5592.5 5617.2 5413.4 5420.8 5431.2 5442.4 5453.9 5403.1 5446.8 5449.9 5454.9 5455.7 5178.6 5310.3 5362.1 5377.6 5425.2 5475.3 5481.9 5485.6 5492.7 5495.9 5198.4 5329.5 5379.6 5385.6 5392.4 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | [#1] ext.html Cycles:180 Average:44544.38 Median:35258.88 stddev:76012.26 (215.6%) stddev-sans-first:76153.68 07:50:38 INFO - PROCESS | 25130 | Values: 535.6 548.8 597.0 600.3 608.5 28497.9 29358.9 29361.3 29385.9 29468.3 40219.4 40653.8 40695.2 40700.6 40756.2 8522.3 8733.6 8736.7 8740.1 8741.8 8558.7 8685.2 8687.7 8691.6 8691.8 8619.7 8699.7 8705.7 8712.3 8712.3 8583.0 8659.7 8660.3 8664.5 8705.8 8509.5 8608.9 8629.2 8629.8 8632.1 40976.8 41371.6 41371.6 41430.8 41434.4 3033.6 3055.6 3057.8 3061.3 3185.2 30025.4 30306.8 30713.0 30730.5 30788.4 3851.9 3877.4 3881.7 3883.2 3980.5 267397.0 269122.0 269146.0 269186.0 269806.7 56806.1 56838.4 57159.4 57209.7 57254.0 60183.4 60223.4 60255.4 60464.0 60504.4 14992.7 15177.1 15192.2 15207.3 15217.5 12005.9 12147.2 12147.3 12150.9 12155.5 18053.8 18439.0 18604.9 18618.1 18690.2 7350.4 7492.3 7588.7 7660.9 7678.9 817.1 846.0 954.5 979.2 986.0 26975.3 27726.4 28636.9 28723.0 30961.8 956.6 998.7 1013.3 1073.2 1082.5 12030.6 14944.4 15817.2 16301.8 16566.6 249666.0 253213.0 253355.0 254339.0 450342.0 42832.0 43212.6 50896.7 52820.2 52861.5 1265.4 1363.1 1368.3 1372.9 1483.4 25098.6 25141.6 25174.2 25196.5 25668.0 39299.2 39815.4 39891.6 39929.0 39961.8 242974.0 279364.0 316114.0 317562.0 321078.0 29031.7 29051.7 29227.9 29475.9 29486.9 37818.2 37981.4 38001.8 38035.4 38056.2 23663.5 31211.8 31532.4 34368.1 35363.5 32935.0 33195.0 34854.5 36393.0 37158.6 33502.2 35154.3 35444.3 35454.8 35478.3 27764.7 29573.6 29745.7 33269.8 33488.0 21178.0 21434.7 25555.7 25927.2 26471.3 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | [#2] jquery.html Cycles:180 Average:23647.19 Median:4740.41 stddev:67801.33 (1430.3%) stddev-sans-first:67968.97 07:50:38 INFO - PROCESS | 25130 | Values: 355.8 356.4 365.5 369.9 371.0 16497.4 16829.4 17379.0 18254.2 18269.0 15577.8 15964.3 15979.4 16014.5 16198.0 5348.9 5476.8 5479.1 5509.6 5510.7 5433.4 5474.4 5477.7 5478.6 5479.4 5434.7 5445.4 5449.8 5452.2 5454.7 5395.5 5410.5 5435.4 5442.2 5451.9 3614.5 3657.6 3773.6 3779.9 3781.8 19321.7 19355.9 19932.0 19941.2 19955.8 2127.3 2165.8 2180.3 2199.8 2253.1 9190.8 9609.3 9671.0 9720.0 12600.6 1724.3 1786.7 1856.0 1867.4 1995.2 59561.0 62743.0 63021.4 63456.4 67307.0 9580.0 9727.3 10209.0 10295.7 10388.3 13768.9 13824.3 13908.7 13914.7 13948.6 7269.6 7347.2 7375.6 7621.6 7623.7 6947.1 7137.8 7155.5 7174.2 7219.1 4662.9 4739.6 4741.2 4803.6 4808.9 1851.6 1857.6 1891.8 1897.6 1931.7 830.0 859.0 940.2 1045.3 1088.4 16321.6 16613.8 16983.2 17582.6 18023.1 908.7 938.3 939.0 988.4 1080.4 8954.3 9935.3 10076.0 10151.3 10378.7 401990.0 405098.0 416405.0 420048.0 424247.0 55644.2 71826.6 71834.6 72015.3 72063.0 874.7 909.7 987.2 988.5 991.3 10714.3 14966.0 15054.4 15151.9 15331.8 26778.3 27796.7 33964.0 34917.3 34945.7 32928.7 33069.2 33078.2 33098.0 33103.5 6460.3 6564.0 6567.8 6571.6 6579.6 5374.7 7298.7 7367.0 7377.8 7382.3 8565.1 8581.6 8582.2 8593.1 8640.4 6932.9 10291.3 11222.2 11384.7 11417.7 10449.0 10455.6 10474.1 10474.3 10644.5 7680.3 7753.8 7818.7 8014.3 8186.1 6101.5 8374.3 8412.9 8419.9 8425.2 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | [#3] mootools.html Cycles:180 Average:5537.60 Median:6284.71 stddev:2967.42 (47.2%) stddev-sans-first:2958.47 07:50:38 INFO - PROCESS | 25130 | Values: 1278.7 1352.9 1410.7 1420.7 1823.4 7728.0 7935.9 7949.0 7954.6 7956.0 7762.7 7767.1 7770.5 7770.7 7794.8 2016.4 2055.1 2272.8 2301.7 2324.3 2317.4 2318.6 2320.4 2321.9 2323.5 2225.8 2276.8 2290.2 2290.3 2291.0 2237.1 2264.8 2266.7 2278.6 2305.9 2260.0 2274.4 2293.9 2298.1 2298.5 7917.5 7971.6 7972.2 7977.8 7985.3 4703.5 4788.6 4793.4 4819.1 4824.1 2992.2 3098.2 3111.7 3144.2 3145.7 975.8 1002.0 1009.9 1010.8 1044.2 11096.8 11123.7 11183.4 11185.6 11186.9 3981.5 4074.2 4089.8 4112.3 4207.0 8636.5 8677.2 8720.3 8728.6 8735.9 4753.8 4756.1 4758.1 4761.5 4779.4 3887.6 4243.9 4301.3 4330.1 4333.9 3459.9 3506.4 3532.1 3559.8 3574.0 1048.0 1051.4 1052.0 1058.3 1059.2 1047.4 1067.7 1067.8 1249.5 1394.9 7359.5 7480.0 7803.9 7809.7 7869.2 457.5 464.4 483.5 488.1 490.0 5978.9 5985.4 5986.1 5986.9 6080.2 9355.9 9805.1 9930.9 9944.0 9989.6 9755.9 9789.0 9802.2 9823.2 9828.2 7454.7 7683.2 7764.8 7767.2 7770.1 7369.2 7479.9 7486.3 7486.6 7492.9 8614.8 8657.0 8679.9 8700.3 8910.7 8729.3 8896.0 9013.4 9041.9 9077.7 6098.5 6239.3 6330.2 6859.0 7006.6 7559.6 7591.7 7616.5 7636.4 7638.0 6774.4 7085.2 7147.0 7158.6 7166.3 6848.1 6910.6 7070.3 7106.0 7144.4 7159.1 7178.0 7183.8 7196.4 7215.3 6666.6 6700.6 6715.6 6718.0 6722.9 6529.8 6680.9 6734.1 6744.6 6752.4 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | [#4] prototype.html Cycles:180 Average:5169.79 Median:5832.68 stddev:1546.74 (26.5%) stddev-sans-first:1507.80 07:50:38 INFO - PROCESS | 25130 | Values: 329.1 330.7 341.6 342.3 344.6 5806.3 5821.6 5823.3 5850.3 5861.9 5769.8 5778.0 5779.2 5788.0 5799.9 4341.5 4437.6 4517.9 4568.2 4574.0 4523.2 4558.1 4567.8 4571.7 4572.6 4322.2 4538.8 4547.0 4550.3 4557.2 4413.4 4512.8 4522.7 4524.3 4547.4 4001.3 4001.9 4009.0 4014.1 4017.6 5551.8 5553.1 5553.3 5560.7 5567.4 5242.3 5246.5 5248.3 5251.5 5253.6 6129.1 6134.3 6144.9 6145.1 6150.0 4181.7 4297.1 4299.5 4300.5 4419.2 6272.1 6324.8 6333.2 6352.7 6362.2 4391.6 4391.9 4393.8 4397.2 4398.5 4452.9 4456.9 4458.7 4459.3 4459.9 5131.8 5136.2 5140.8 5144.1 5147.0 6146.5 6147.1 6150.6 6159.7 6163.4 1557.8 1579.7 1581.5 1583.5 1584.0 955.3 991.4 1046.3 1051.3 1067.3 5790.6 5802.4 5833.6 5841.1 5844.4 6256.8 6258.7 6258.7 6258.9 6269.1 5829.3 5831.1 5831.8 5838.1 5842.1 3324.0 3345.0 3363.9 3365.6 3378.4 6472.0 6543.4 6563.6 6702.6 6706.4 6468.1 6475.7 6507.7 6509.0 6512.3 6692.0 6692.6 6694.8 6697.3 6702.6 6352.1 6356.1 6360.3 6360.4 6364.8 6286.3 6298.2 6298.8 6298.9 6310.1 6517.4 6576.5 6673.0 6680.1 6688.4 4375.6 4377.1 4401.8 4411.6 4419.6 6094.1 6341.2 6369.8 6383.1 6389.3 6036.5 6175.0 6216.7 6217.6 6228.1 6165.7 6179.8 6180.5 6186.5 6201.4 6067.9 6073.9 6074.5 6077.0 6083.3 6193.0 6228.3 6230.6 6233.6 6245.6 5890.7 6061.5 6098.1 6123.1 6124.8 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - PROCESS | 25130 | [#5] yui.html Cycles:180 Average:13362.22 Median:47655.14 stddev:15233.99 (32.0%) stddev-sans-first:15247.27 07:50:38 INFO - PROCESS | 25130 | Values: 746.3 750.4 758.5 761.2 773.1 12774.9 12907.9 12967.9 12972.0 12976.6 12746.2 13934.9 14156.8 14182.5 14188.4 541.1 541.8 542.1 547.8 691.0 835.8 844.5 848.7 850.0 850.5 889.8 891.4 893.4 897.9 898.4 720.8 886.3 886.6 886.8 894.4 648.3 650.7 652.6 652.7 652.8 13602.1 13602.3 13602.7 13614.5 13630.5 12588.6 12595.2 12985.5 13151.2 13330.3 9973.6 10241.8 10857.3 10962.4 11104.3 3521.7 3532.6 3639.4 3711.0 3713.2 49853.8 51015.7 51022.7 51058.5 51065.0 9512.4 9780.7 10038.6 10180.6 10739.6 17836.5 17839.3 18184.3 18369.2 18413.3 7549.8 7783.0 7784.2 7896.8 8047.9 4109.1 4207.9 4284.0 4299.9 4349.9 2965.9 2978.1 2983.9 2992.9 3005.6 558.0 563.6 566.2 566.2 566.6 648.5 650.2 653.2 665.1 687.0 7862.5 8301.5 8494.7 8767.0 9405.1 603.7 620.7 658.7 672.2 672.5 3777.0 3787.3 3885.3 3980.2 4195.0 51511.0 53990.5 54354.0 54376.7 54466.2 45833.8 47602.8 47707.5 47926.5 48031.0 43156.8 44953.0 45485.5 45761.5 45834.5 7431.6 7764.9 7771.2 7777.1 7785.6 33350.8 33741.3 34706.3 34732.1 35142.3 37385.6 38697.0 39521.0 39597.8 39610.0 6977.7 10492.5 10609.5 10620.4 10622.0 8831.9 10865.6 10948.1 11327.3 11588.2 9660.4 10882.6 11419.5 11530.9 12015.6 11607.1 11944.0 12072.6 12100.4 12180.9 11114.7 11333.4 11457.5 11530.9 11928.5 9031.4 9032.2 9101.3 9504.3 9526.0 8459.7 8555.7 8638.8 9400.6 9669.8 07:50:38 INFO - PROCESS | 25130 | -------- Summary: end -------- 07:50:38 INFO - PROCESS | 25130 | 07:50:38 INFO - TEST-INFO | 25130: exit 0 07:50:38 INFO - TEST-OK | dromaeo_css | took 1115503ms 07:50:38 INFO - TEST-START | kraken 07:50:38 INFO - operating with platform_type : linux_ 07:50:38 INFO - Initialising browser for kraken test... 07:50:38 INFO - TEST-INFO | started process 25359 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLH97z2/profile http://localhost:44262/getInfo.html) 07:50:43 INFO - PROCESS | 25359 | __metrics Screen width/height:1600/1200 07:50:43 INFO - PROCESS | 25359 | colorDepth:24 07:50:43 INFO - PROCESS | 25359 | Browser inner width/height: 1024/697 07:50:43 INFO - PROCESS | 25359 | __metrics 07:50:44 ERROR - PROCESS | 25359 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:50:45 INFO - TEST-INFO | 25359: exit 0 07:50:45 INFO - Browser initialized. 07:50:45 INFO - Running cycle 1/1 for kraken test... 07:50:45 INFO - TEST-INFO | started process 25442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLH97z2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:57 INFO - PROCESS | 25442 | RSS: Main: 154976256 07:50:57 INFO - PROCESS | 25442 | 07:50:59 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44262/tests/kraken/driver.html?testName=audio-beat-detection) 07:51:00 INFO - PROCESS | 25442 | RSS: Main: 195616768 07:51:00 INFO - PROCESS | 25442 | 07:51:02 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44262/tests/kraken/driver.html?testName=audio-dft) 07:51:03 INFO - PROCESS | 25442 | RSS: Main: 184827904 07:51:03 INFO - PROCESS | 25442 | 07:51:06 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44262/tests/kraken/driver.html?testName=audio-fft) 07:51:06 INFO - PROCESS | 25442 | RSS: Main: 171397120 07:51:06 INFO - PROCESS | 25442 | 07:51:08 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44262/tests/kraken/driver.html?testName=audio-oscillator) 07:51:09 INFO - PROCESS | 25442 | RSS: Main: 172822528 07:51:09 INFO - PROCESS | 25442 | 07:51:11 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:51:12 INFO - PROCESS | 25442 | RSS: Main: 174927872 07:51:12 INFO - PROCESS | 25442 | 07:51:15 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44262/tests/kraken/driver.html?testName=imaging-darkroom) 07:51:15 INFO - PROCESS | 25442 | RSS: Main: 175099904 07:51:15 INFO - PROCESS | 25442 | 07:51:19 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44262/tests/kraken/driver.html?testName=imaging-desaturate) 07:51:19 INFO - PROCESS | 25442 | RSS: Main: 174669824 07:51:19 INFO - PROCESS | 25442 | 07:51:22 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44262/tests/kraken/driver.html?testName=json-parse-financial) 07:51:23 INFO - PROCESS | 25442 | RSS: Main: 175108096 07:51:23 INFO - PROCESS | 25442 | 07:51:24 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:25 INFO - PROCESS | 25442 | RSS: Main: 183939072 07:51:25 INFO - PROCESS | 25442 | 07:51:27 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:27 INFO - PROCESS | 25442 | RSS: Main: 180883456 07:51:27 INFO - PROCESS | 25442 | 07:51:29 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:30 INFO - PROCESS | 25442 | RSS: Main: 192503808 07:51:30 INFO - PROCESS | 25442 | 07:51:32 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:33 INFO - PROCESS | 25442 | RSS: Main: 196825088 07:51:33 INFO - PROCESS | 25442 | 07:51:36 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:36 INFO - PROCESS | 25442 | RSS: Main: 197185536 07:51:36 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | Cycle 1(1): loaded http://localhost:44262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44262/tests/kraken/driver.html?testName=ai-astar) 07:51:38 INFO - PROCESS | 25442 | RSS: Main: 257802240 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | __start_tp_report 07:51:38 INFO - PROCESS | 25442 | _x_x_mozilla_page_load 07:51:38 INFO - PROCESS | 25442 | _x_x_mozilla_page_load_details 07:51:38 INFO - PROCESS | 25442 | |i|pagename|runs| 07:51:38 INFO - PROCESS | 25442 | |0;ai-astar;109;110;105;109;111;109;99;110;109;108 07:51:38 INFO - PROCESS | 25442 | |1;audio-beat-detection;151;127;148;183;133;156;158;134;169;133 07:51:38 INFO - PROCESS | 25442 | |2;audio-dft;161;160;161;161;161;162;163;166;163;160 07:51:38 INFO - PROCESS | 25442 | |3;audio-fft;77;75;111;95;75;76;76;120;93;76 07:51:38 INFO - PROCESS | 25442 | |4;audio-oscillator;93;92;146;93;93;94;149;93;93;136 07:51:38 INFO - PROCESS | 25442 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;116 07:51:38 INFO - PROCESS | 25442 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;146;145 07:51:38 INFO - PROCESS | 25442 | |7;imaging-desaturate;96;96;95;95;95;96;96;96;96;96 07:51:38 INFO - PROCESS | 25442 | |8;json-parse-financial;57;55;56;58;58;56;56;65;54;54 07:51:38 INFO - PROCESS | 25442 | |9;json-stringify-tinderbox;69;69;68;68;69;68;69;69;68;68 07:51:38 INFO - PROCESS | 25442 | |10;stanford-crypto-aes;82;83;82;81;88;83;82;83;83;81 07:51:38 INFO - PROCESS | 25442 | |11;stanford-crypto-ccm;113;115;114;115;115;123;113;113;115;122 07:51:38 INFO - PROCESS | 25442 | |12;stanford-crypto-pbkdf2;151;141;151;154;149;139;148;148;148;150 07:51:38 INFO - PROCESS | 25442 | |13;stanford-crypto-sha256-iterative;68;69;68;68;67;67;68;68;67;67 07:51:38 INFO - PROCESS | 25442 | __end_tp_report 07:51:38 INFO - PROCESS | 25442 | __start_cc_report 07:51:38 INFO - PROCESS | 25442 | _x_x_mozilla_cycle_collect,1083 07:51:38 INFO - PROCESS | 25442 | __end_cc_report 07:51:38 INFO - PROCESS | 25442 | __startTimestamp1457538698556__endTimestamp 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | ------- Summary: start ------- 07:51:38 INFO - PROCESS | 25442 | Number of tests: 14 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.51 (3.2%) stddev-sans-first:3.70 07:51:38 INFO - PROCESS | 25442 | Values: 109.0 110.0 105.0 109.0 111.0 109.0 99.0 110.0 109.0 108.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.50 stddev:17.99 (11.7%) stddev-sans-first:19.07 07:51:38 INFO - PROCESS | 25442 | Values: 151.0 127.0 148.0 183.0 133.0 156.0 158.0 134.0 169.0 133.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 07:51:38 INFO - PROCESS | 25442 | Values: 161.0 160.0 161.0 161.0 161.0 162.0 163.0 166.0 163.0 160.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#3] audio-fft Cycles:10 Average:87.40 Median:76.00 stddev:16.71 (22.0%) stddev-sans-first:17.30 07:51:38 INFO - PROCESS | 25442 | Values: 77.0 75.0 111.0 95.0 75.0 76.0 76.0 120.0 93.0 76.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.00 stddev:24.69 (26.5%) stddev-sans-first:25.57 07:51:38 INFO - PROCESS | 25442 | Values: 93.0 92.0 146.0 93.0 93.0 94.0 149.0 93.0 93.0 136.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:51:38 INFO - PROCESS | 25442 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:51:38 INFO - PROCESS | 25442 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:51:38 INFO - PROCESS | 25442 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:3.18 (5.6%) stddev-sans-first:3.37 07:51:38 INFO - PROCESS | 25442 | Values: 57.0 55.0 56.0 58.0 58.0 56.0 56.0 65.0 54.0 54.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:51:38 INFO - PROCESS | 25442 | Values: 69.0 69.0 68.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.99 (2.4%) stddev-sans-first:2.09 07:51:38 INFO - PROCESS | 25442 | Values: 82.0 83.0 82.0 81.0 88.0 83.0 82.0 83.0 83.0 81.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:115.00 stddev:3.65 (3.2%) stddev-sans-first:3.72 07:51:38 INFO - PROCESS | 25442 | Values: 113.0 115.0 114.0 115.0 115.0 123.0 113.0 113.0 115.0 122.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.50 stddev:4.58 (3.1%) stddev-sans-first:4.72 07:51:38 INFO - PROCESS | 25442 | Values: 151.0 141.0 151.0 154.0 149.0 139.0 148.0 148.0 148.0 150.0 07:51:38 INFO - PROCESS | 25442 | 07:51:38 INFO - PROCESS | 25442 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 07:51:38 INFO - PROCESS | 25442 | Values: 68.0 69.0 68.0 68.0 67.0 67.0 68.0 68.0 67.0 67.0 07:51:38 INFO - PROCESS | 25442 | -------- Summary: end -------- 07:51:38 INFO - PROCESS | 25442 | 07:51:39 INFO - TEST-INFO | 25442: exit 0 07:51:39 INFO - TEST-OK | kraken | took 60484ms 07:51:39 INFO - SUITE-END | took 1175s 07:51:39 INFO - Completed test suite (00:19:36) 07:51:39 INFO - javascript benchmark 07:51:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.780355375122, 3176.825274609896, 3227.4997375406806, 3239.7894136881114, 3259.7555183361255, 5077.79688812448, 5152.768125434355, 5153.458886816887, 5201.453847346031, 5260.947390526098, 5164.070467315891, 5185.714785686786, 5194.584433245341, 5217.217417387394, 5259.973700131494, 4687.226607609758, 4756.738379389141, 4808.08646357191, 4815.0610630926985, 4835.516448355172, 4645.651576131803, 4718.174319494092, 4753.928691069636, 4764.714117152982, 4889.755512224392, 4744.122337367598, 4747.382840230783, 4761.023990082025, 4775.116603428377, 4785.497522760113, 4728.976355118237, 4745.976270118662, 4748.240281554935, 4768.0, 4772.451168115676, 4627.884302892421, 4698.060387922429, 4752.334673145762, 4762.0, 4789.952100478986, 5053.343065401511, 5070.594352451795, 5070.873228169288, 5098.974505127488, 5106.923396149061, 5555.749991250363, 5558.082916318803, 5559.861003474945, 5569.359523654751, 5613.663180209201, 5485.6982865942355, 5580.051391263495, 5621.4659607337235, 5653.23681303027, 5658.34928983164, 5190.06578815813, 5193.584513238932, 5198.142306519419, 5200.999999999962, 5243.082460569423, 5637.379888212294, 5638.04153293941, 5639.266895303666, 5643.746031428514, 5643.802466913638, 5314.946850531523, 5448.182772584065, 5452.509274165344, 5488.368837583729, 5546.58400619947, 5529.253550770675, 5565.916511252334, 5566.6381685191145, 5566.693831839288, 5569.220309156722, 5537.335519737658, 5537.363203231599, 5542.889142217133, 5543.8891222176135, 5590.273264475673, 5366.6243362964215, 5537.086380747212, 5580.2466666999435, 5610.915836262459, 5636.633618814764, 4247.766372849461, 4262.744235345889, 4263.040815816478, 4263.616274535307, 4295.033617436052, 3740.588535261119, 3837.5586807516934, 3845.9038524036564, 3869.6517313441927, 3889.649931506178, 5102.2346648003095, 5148.30497882781, 5150.510701483353, 5163.173892177234, 5203.661761985459, 5535.142052981794, 5565.526930210896, 5577.330720313588, 5579.832605021856, 5594.86012849682, 5062.215356619657, 5164.509371609691, 5204.167333226741, 5205.635605507654, 5236.554892834151, 4748.121597504472, 4772.451168115711, 4778.832740854054, 4790.928136077961, 4809.879753006203, 5837.387074357216, 5876.882462350729, 5877.764889404376, 5882.911756323744, 5927.525797936155, 5399.325084364455, 5528.889422211453, 5601.243832082617, 5607.327120745536, 5617.4101719320515, 5860.062390017577, 5868.2664666916635, 5877.500412464989, 5878.088896221093, 5882.852928676817, 5514.310711161105, 5538.667679939216, 5541.0, 5541.556675466034, 5563.888722225452, 5461.15352120422, 5541.584381171348, 5571.637843540157, 5592.496675299242, 5617.241672374177, 5413.377461591967, 5420.83737487876, 5431.23962645222, 5442.37412697529, 5453.945460545344, 5403.13549832025, 5446.754896029609, 5449.891002180014, 5454.945450545602, 5455.672659640434, 5178.61160412963, 5310.256564081109, 5362.088444964444, 5377.569794416359, 5425.159100339453, 5475.288212532505, 5481.945180548143, 5485.61600687964, 5492.697901615449, 5495.890082198413, 5198.350206224222, 5329.520343169133, 5379.569634429315, 5385.6230063895155, 5392.379876314274], "unit": "score", "name": "dojo.html", "value": 5139.334568150911}, {"lowerIsBetter": false, "replicates": [535.6357676779788, 548.7859734703467, 597.0298265318856, 600.3066458240733, 608.4523928464381, 28497.85751071244, 29358.853205733994, 29361.265968350774, 29385.853070734618, 29468.263293417676, 40219.39670904932, 40653.7967310163, 40695.186096278056, 40700.592994070124, 40756.18487630245, 8522.33814406191, 8733.563321833915, 8736.650533978633, 8740.082291359411, 8741.825163496726, 8558.743237702878, 8685.218330350268, 8687.652493900268, 8691.60887760049, 8691.782705432382, 8619.741407757778, 8699.652013919467, 8705.738827835175, 8712.259457946082, 8712.259457946082, 8582.957085214564, 8659.696910608161, 8660.263877570382, 8664.48013119215, 8705.7823554411, 8509.489430634181, 8608.870866937, 8629.223369896677, 8629.784255393666, 8632.093630168805, 40976.79511602453, 41371.586284137076, 41371.586284137076, 41430.792846035576, 41434.37848432276, 3033.5752994580776, 3055.5569442430947, 3057.785954983152, 3061.3112049788842, 3185.2355434695737, 30025.399492010038, 30306.84846575775, 30713.0, 30730.539041914388, 30788.384232315453, 3851.903702407434, 3877.4377715231135, 3881.71254371918, 3883.184531248441, 3980.5223373195404, 267397.0, 269122.0, 269146.0, 269186.0, 269806.65096674586, 56806.147907781415, 56838.43161568414, 57159.428405716244, 57209.71395143081, 57254.0, 60183.39816601778, 60223.39776602178, 60255.397446025854, 60464.0, 60504.39495605075, 14992.70014599702, 15177.089374637557, 15192.164430956404, 15207.31567079484, 15217.467388641344, 12005.91946724799, 12147.210431321935, 12147.271163730204, 12150.939245303716, 12155.453004614814, 18053.819461805477, 18439.0, 18604.906975465037, 18618.06909654539, 18690.158942847604, 7350.4119670426235, 7492.325690687864, 7588.658510367047, 7660.885086723703, 7678.884816727754, 817.1379194949385, 845.9830803384021, 954.5179684259405, 979.1628157925014, 986.0386123529502, 26975.325616859736, 27726.445471090465, 28636.85681571579, 28723.0, 30961.845190773904, 956.6030097509456, 998.6554638649654, 1013.2856336282903, 1073.1951036722458, 1082.4966390628394, 12030.578929737418, 14944.402223910922, 15817.209139542976, 16301.755473667905, 16566.585835354213, 249666.0, 253213.0, 253355.0, 254339.0, 450342.0, 42832.0, 43212.56787432148, 50896.74551627218, 52820.20769688381, 52861.47138528642, 1265.3926115464628, 1363.0867318896362, 1368.3158420789605, 1372.8901687864948, 1483.3547406878042, 25098.62352064684, 25141.622875656514, 25174.24477265685, 25196.49607007886, 25667.97328106855, 39299.2140157201, 39815.402768959066, 39891.60108398879, 39929.0, 39961.80019099886, 242974.0, 279364.0, 316114.0, 317562.0, 321078.0, 29031.7096829029, 29051.709482905746, 29227.85386073141, 29475.852620736758, 29486.852565737892, 37818.24363512769, 37981.430278546395, 38001.80999094987, 38035.42946855744, 38056.238875222894, 23663.52672946497, 31211.843940780152, 31532.36935261236, 34368.14079647929, 35363.46954795731, 32935.0, 33195.0, 34854.47718284177, 36393.0, 37158.628413715516, 33502.162445939044, 35154.296914061066, 35444.291114178086, 35454.822725887236, 35478.29043419169, 27764.722352777022, 29573.556396654498, 29745.70254297516, 33269.83365083159, 33488.0, 21178.0, 21434.6784798225, 25555.744442555337, 25927.22218333453, 26471.33821654474], "unit": "score", "name": "ext.html", "value": 17724.618540175077}, {"lowerIsBetter": false, "replicates": [355.7527518374729, 356.4225953954594, 365.528468275924, 369.8686966127023, 371.01495529369515, 16497.42259020933, 16829.41097061603, 17379.044152571605, 18254.17856196471, 18269.0, 15577.844221557782, 15964.28160732767, 15979.440719574817, 16014.519564413085, 16198.0, 5348.91976620351, 5476.7535460904155, 5479.123340265558, 5509.614326997112, 5510.724463776815, 5433.429489903562, 5474.42518535554, 5477.698726570037, 5478.561715062805, 5479.369872464657, 5434.673919564819, 5445.428230035848, 5449.809256676017, 5452.182172674091, 5454.699991500466, 5395.541378982791, 5410.513053825155, 5435.374931882845, 5442.2380866678495, 5451.918221226685, 3614.4759009943673, 3657.579378371495, 3773.641504057138, 3779.8866034019024, 3781.7730936143644, 19321.710174347398, 19355.90322048395, 19932.0, 19941.202351905908, 19955.800441995685, 2127.319257837493, 2165.8375621828427, 2180.269609680743, 2199.846010779246, 2253.0649780341137, 9190.816183676356, 9609.327347085708, 9671.0, 9719.951400242953, 12600.558980435733, 1724.2930398536664, 1786.696261635512, 1855.9536011599819, 1867.3557622620174, 1995.1520603743352, 59561.0, 62743.0, 63021.369786302006, 63456.365436345506, 67307.0, 9579.952100239454, 9727.270454715925, 10209.0, 10295.742606434898, 10388.272820902615, 13768.862311376757, 13824.308784560732, 13908.652283692787, 13914.721705565831, 13948.58154255374, 7269.63651817407, 7347.228541003225, 7375.631218439056, 7621.580813055335, 7623.656935437919, 6947.131608548932, 7137.785866424016, 7155.499115062, 7174.210836807947, 7219.0976127984, 4662.906741865144, 4739.644526660445, 4741.170295198395, 4803.567678908845, 4808.927866082012, 1851.6111616560404, 1857.5913299074182, 1891.7635295588052, 1897.5635603811202, 1931.7102434634637, 829.9626516806758, 859.0207163833235, 940.1867384712175, 1045.3153184664056, 1088.3905013192636, 16321.591960200853, 16613.833861661227, 16983.150842457828, 17582.560435988948, 18023.098845057695, 908.6955869783565, 938.2915898496591, 939.0093451408693, 988.4415305352453, 1080.4111759091313, 8954.328425368123, 9935.254855885838, 10076.0, 10151.340162889388, 10378.688639340831, 401990.0, 405098.0, 416405.0, 420048.0, 424247.0, 55644.16533751916, 71826.64086679534, 71834.64082679553, 72015.2798472019, 72063.0, 874.7157173918501, 909.6725178935578, 987.1559816357055, 988.5057471264367, 991.2813210422386, 10714.269142069887, 14965.952383333062, 15054.397824086915, 15151.924240378728, 15331.77002344988, 26778.330541736614, 27796.722032779413, 33964.0, 34917.30165396627, 34945.65054349424, 32928.67071329256, 33069.17327066843, 33078.17304567405, 33098.0, 33103.50344744879, 6460.25707043696, 6564.0, 6567.802965911031, 6571.605703657796, 6579.572327798678, 5374.707259953223, 7298.744543940937, 7366.96316518414, 7377.8155546111775, 7382.335589796944, 8565.100664430394, 8581.570921454027, 8582.184692454206, 8593.097724738813, 8640.438371505832, 6932.896006560007, 10291.33106348085, 11222.214444988773, 11384.658460246206, 11417.657470275904, 10449.0, 10455.634052808115, 10474.109700675528, 10474.319169253975, 10644.520996555018, 7680.308772210527, 7753.844923101619, 7818.687252509836, 8014.318782903519, 8186.09952905168, 6101.5118790497545, 8374.2881855043, 8412.915870841212, 8419.8737018946, 8425.157484251526], "unit": "score", "name": "jquery.html", "value": 7880.248343721628}, {"lowerIsBetter": false, "replicates": [1278.6867217531703, 1352.9255890925995, 1410.6755446247362, 1420.6661434562875, 1823.4073925974053, 7727.99536060312, 7935.92064079359, 7949.0, 7954.562499062549, 7955.960220198898, 7762.650680719367, 7767.145613982458, 7770.494917830351, 7770.728024519143, 7794.8441031179345, 2016.3850025742142, 2055.0649454498166, 2272.8181745460324, 2301.6892719482908, 2324.3027091872373, 2317.351141680332, 2318.6174281243575, 2320.443093657527, 2321.94195145121, 2323.488832456857, 2225.810806081485, 2276.804677544286, 2290.1526435218993, 2290.290010096867, 2290.9656355154684, 2237.1275202671054, 2264.8074913632363, 2266.6939963104933, 2278.646809744476, 2305.896234669444, 2259.9548009039727, 2274.397284719534, 2293.896774645145, 2298.092253559851, 2298.528801595669, 7917.485363451415, 7971.561564113971, 7972.20277972204, 7977.760667179994, 7985.321247693953, 4703.482616912137, 4788.569028787426, 4793.3768610080815, 4819.0602832447685, 4824.107540105092, 2992.2369795702175, 3098.2409309719037, 3111.6577176510564, 3144.166795799115, 3145.6697046810214, 975.7511834482233, 1002.0380434782618, 1009.8636684047633, 1010.8129995950699, 1044.2011860926398, 11096.833547496793, 11123.721906952229, 11183.440827958651, 11185.552577896875, 11186.944065279622, 3981.5421226558738, 4074.2258970795456, 4089.8364065437645, 4112.321466957978, 4206.957930420718, 8636.481811091355, 8677.175668311627, 8720.258778003814, 8728.563571821383, 8735.868961965576, 4753.762311884392, 4756.096341695136, 4758.072175925661, 4761.4524329701835, 4779.402574678165, 3887.5723670396233, 4243.872683819491, 4301.3117901135665, 4330.069035157393, 4333.8699839004885, 3459.930801383958, 3506.3513250048823, 3532.0993146747414, 3559.839807208682, 3573.9821300893327, 1047.9685609431729, 1051.3796859852723, 1051.994740026295, 1058.317385286486, 1059.1950117910444, 1047.4134484688598, 1067.690369792767, 1067.765091679829, 1249.5251804314485, 1394.902356835012, 7359.521631094069, 7479.962600186965, 7803.921960780433, 7809.687612495437, 7869.213078692085, 457.5310306935351, 464.41251816452217, 483.48750324655975, 488.131126594655, 489.9828506002344, 5978.850528736816, 5985.431384018511, 5986.102084687332, 5986.850328741816, 6080.209572755602, 9355.859662105075, 9805.117539421486, 9930.851037234448, 9943.950280248697, 9989.600415983425, 9755.853662195073, 9788.951055244679, 9802.215822734164, 9823.214142868554, 9828.164606008426, 7454.664540095709, 7683.154852966281, 7764.767056988299, 7767.18444563324, 7770.14528401864, 7369.226231245856, 7479.850402991801, 7486.326230639269, 7486.625668716433, 7492.850142997, 8614.78463038429, 8657.0, 8679.86980195285, 8700.347473939353, 8910.732678019669, 8729.345299102719, 8895.955520222617, 9013.414128081917, 9041.864372034293, 9077.727668169966, 6098.512119030378, 6239.251289845066, 6330.177076979963, 6858.971154326891, 7006.579605223703, 7559.584222867795, 7591.734289299848, 7616.504927179715, 7636.427267954815, 7638.0, 6774.390304872585, 7085.220625731063, 7147.035150254649, 7158.570485770871, 7166.283371662792, 6848.14398200225, 6910.619915904473, 7070.328318809705, 7106.040684507525, 7144.428445724434, 7159.140903091662, 7178.0, 7183.784486465414, 7196.424286056998, 7215.314545118205, 6666.566673166229, 6700.597964122168, 6715.630640314829, 6718.0, 6722.865542689021, 6529.836754080996, 6680.899786503109, 6734.057231987427, 6744.595324280559, 6752.358525940224], "unit": "score", "name": "mootools.html", "value": 4415.62297183529}, {"lowerIsBetter": false, "replicates": [329.05396983671943, 330.73871641403287, 341.56279961649096, 342.3239102772024, 344.5951007566111, 5806.332271788746, 5821.621594596349, 5823.272090988627, 5850.268716410449, 5861.882762344761, 5769.7692092316365, 5778.0, 5779.162021506879, 5788.04497257953, 5799.9130013049835, 4341.544137865526, 4437.5562443755525, 4517.887052823673, 4568.154891345095, 4573.954260457386, 4523.185826551219, 4558.088382323532, 4567.8172873085205, 4571.748553829538, 4572.634189264851, 4322.200392927302, 4538.773061346936, 4547.045120524694, 4550.340200670901, 4557.179707652621, 4413.426254586915, 4512.7743612819395, 4522.660800439948, 4524.276115821485, 4547.431571053618, 4001.3197756381487, 4001.9399709004388, 4009.037830920587, 4014.116894283253, 4017.598240175959, 5551.777928882881, 5553.139263414178, 5553.278073850414, 5560.749766260528, 5567.359753628344, 5242.344706911636, 5246.501582349709, 5248.343957005374, 5251.474852514756, 5253.605979551549, 6129.080637904305, 6134.325224225332, 6144.938550614482, 6145.139680444741, 6150.04674275488, 4181.686373521968, 4297.140571885604, 4299.527052024275, 4300.548442413564, 4419.18245124653, 6272.1219029335925, 6324.810255692337, 6333.20834895638, 6352.714127864211, 6362.2365316161895, 4391.560843915583, 4391.934120988188, 4393.802278897458, 4397.2304846651705, 4398.494173170063, 4452.910941781146, 4456.888577785581, 4458.71018383804, 4459.308807134835, 4459.866204013885, 5131.846044618667, 5136.203888397305, 5140.845774626767, 5144.0997825381155, 5146.996335714574, 6146.477549408351, 6147.0779383092895, 6150.646857691301, 6159.6612186329285, 6163.414475624809, 1557.8208506021726, 1579.7314456542415, 1581.533447632951, 1583.4932821497011, 1584.0179088964915, 955.3074021334477, 991.3605724307926, 1046.2989796836139, 1051.316644181273, 1067.290251982423, 5790.639199788046, 5802.4197580241635, 5833.562482813806, 5841.1238314253205, 5844.444777746107, 6256.843578910563, 6258.655773932386, 6258.718357673915, 6258.906116408258, 6269.059641053878, 5829.329627092939, 5831.096180092092, 5831.79588714393, 5838.065909454467, 5842.094475356326, 3323.9501407478906, 3344.9665503344654, 3363.8654453822064, 3365.6129545102626, 3378.442556978071, 6472.0, 6543.378379053982, 6563.638999855054, 6702.597844129368, 6706.362895524917, 6468.06213099098, 6475.676216189172, 6507.739690412331, 6509.0, 6512.316206798313, 6691.996200569856, 6692.564983276169, 6694.765683201064, 6697.330266973361, 6702.631355275409, 6352.110704501466, 6356.110144579855, 6360.332165122595, 6360.363963603602, 6364.777232797015, 6286.339934307015, 6298.212723409574, 6298.842528936813, 6298.937010630018, 6310.05349197624, 6517.395040265463, 6576.539642224999, 6673.0, 6680.098186744727, 6688.431483323778, 4375.562443755599, 4377.146456441091, 4401.82392704301, 4411.580899814641, 4419.558044195684, 6094.11635312886, 6341.175647165839, 6369.840753981002, 6383.1382763326355, 6389.2971773105855, 6036.456718895321, 6175.042868355412, 6216.658083805253, 6217.595856269328, 6228.065790131516, 6165.660888651168, 6179.752809887734, 6180.505559555315, 6186.5360097993735, 6201.379862013943, 6067.908981365194, 6073.908891366721, 6074.544409169242, 6077.0, 6083.330833608388, 6192.969035154795, 6228.346023667631, 6230.563860529901, 6233.625982441068, 6245.5628106033955, 5890.734916928663, 6061.545384096122, 6098.146259523582, 6123.14276001369, 6124.816255512342], "unit": "score", "name": "prototype.html", "value": 4667.498214964005}, {"lowerIsBetter": false, "replicates": [746.2574738135556, 750.4184257200669, 758.5069704691949, 761.1855314813153, 773.1302284929454, 12774.936125319373, 12907.935460322686, 12967.935160324198, 12972.0, 12976.610701678941, 12746.171498852567, 13934.930325348385, 14156.78764818526, 14182.503612373568, 14188.361523731432, 541.066660011481, 541.8455740114068, 542.0568211312318, 547.7808876449412, 691.0360047733409, 835.7910522369408, 844.5228445928032, 848.6944699908029, 849.9702510412137, 850.4727069217095, 889.7908991387019, 891.3893982621893, 893.3523195683143, 897.8698088777123, 898.371140201858, 720.8197950512372, 886.3042511628373, 886.5700135434341, 886.8049029213595, 894.4365050018512, 648.2965981909633, 650.7494614573376, 652.5953908576665, 652.7030201258416, 652.7552167937024, 13602.115862468909, 13602.251876146807, 13602.727945441135, 13614.455421783117, 13630.522931697442, 12588.559400420942, 12595.173699813477, 12985.545505907343, 13151.21092734439, 13330.266835324053, 9973.601055957753, 10241.795164096677, 10857.34855908648, 10962.397068161248, 11104.333739975627, 3521.7358698097746, 3532.6114127445962, 3639.3813051781262, 3710.9814450927843, 3713.2016616427327, 49853.75073124611, 51015.744921275524, 51022.7448862757, 51058.489415106116, 51065.0, 9512.429254244767, 9780.706578802647, 10038.64864729731, 10180.592776289013, 10739.570417183382, 17836.46490605284, 17839.286428542713, 18184.27262909469, 18369.173387197607, 18413.26346946134, 7549.811254718676, 7783.0, 7784.221577842283, 7896.763097107096, 8047.879281810778, 4109.137081212919, 4207.894802629959, 4284.036091879365, 4299.914001719948, 4349.934750978738, 2965.8813647453862, 2978.1214541710247, 2983.880644774228, 2992.895248666286, 3005.609270794783, 557.9748911299001, 563.630821811714, 566.1620801214226, 566.1762136091976, 566.5524235853712, 648.5071345777243, 650.2164891305965, 653.1933062667601, 665.128681427322, 686.9965650171717, 7862.488938218998, 8301.543415112106, 8494.660213591387, 8767.0, 9405.059494050676, 603.7313395539031, 620.7020630097578, 658.6838317607575, 672.2135101930753, 672.4821887146869, 3776.981115094407, 3787.280416720814, 3885.2812229737588, 3980.20395920817, 4194.972231803166, 51511.0, 53990.46009539933, 54354.0, 54376.728116359955, 54466.18300725492, 45833.77083114563, 47602.76198618985, 47707.52292477031, 47926.520734792204, 48031.035499853024, 43156.78421607872, 44953.0, 45485.54514454879, 45761.542384576394, 45834.54165458303, 7431.628418578941, 7764.92235077642, 7771.1840256774485, 7777.066751989797, 7785.64964576584, 33350.833245833615, 33741.325173495905, 34706.30587388187, 34732.13169670779, 35142.29715405728, 37385.62614373821, 38697.0, 39521.02394880302, 39597.80201098976, 39610.0, 6977.686004129725, 10492.475376231005, 10609.522571484147, 10620.362778233331, 10622.0, 8831.91168088311, 10865.619703310662, 10948.124150068135, 11327.263727857662, 11588.246763960316, 9660.37207581505, 10882.61910833117, 11419.486123124314, 11530.94234528822, 12015.579454719043, 11607.071434285406, 11944.0, 12072.637820865388, 12100.394980251129, 12180.878191217975, 11114.722131946766, 11333.366489282274, 11457.541698332307, 11530.94234528822, 11928.522859085539, 9031.36780425364, 9032.187103160748, 9101.317401195069, 9504.334696571173, 9525.952370238105, 8459.667227780508, 8555.657773688983, 8638.82722345537, 9400.576974036048, 9669.758256043655], "unit": "score", "name": "yui.html", "value": 6157.3975053534305}], "name": "dromaeo_css", "value": 6707.938952191956}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 111.0, 109.0, 99.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 148.0, 183.0, 133.0, 156.0, 158.0, 134.0, 169.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 163.0, 166.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 111.0, 95.0, 75.0, 76.0, 76.0, 120.0, 93.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 146.0, 93.0, 93.0, 94.0, 149.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 58.0, 58.0, 56.0, 56.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 81.0, 88.0, 83.0, 82.0, 83.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [113.0, 115.0, 114.0, 115.0, 115.0, 123.0, 113.0, 113.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [151.0, 141.0, 151.0, 154.0, 149.0, 139.0, 148.0, 148.0, 148.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1511.7000000000003}]} 07:51:39 INFO - Return code: 0 07:51:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:51:39 ERROR - # TBPL SUCCESS # 07:51:39 INFO - Running post-action listener: _resource_record_post_action 07:51:39 INFO - Running post-run listener: _resource_record_post_run 07:51:40 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 2666496; Write bytes: 534495232; Read time: 988; Write time: 512032 07:51:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241217536; Read time: 0; Write time: 313200 07:51:40 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 2666496; Write bytes: 293277696; Read time: 988; Write time: 198832 07:51:40 INFO - Running post-run listener: _upload_blobber_files 07:51:40 INFO - Blob upload gear active. 07:51:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:51:40 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 07:51:40 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:51:40 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:51:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:42 INFO - (blobuploader) - INFO - Done attempting. 07:51:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:43 INFO - (blobuploader) - INFO - Done attempting. 07:51:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:43 INFO - Return code: 0 07:51:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:51:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/018307ef4ac58500521f3f834307566fd64e1f173df0ed3e38d132a59e4b67e0a8e4748e89da7aa9165ce0c75f0c6a3a316a8a8093dee95c1ebad24706c56c5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af4430e95b93cd06549140f34275bad679a2a7950752d110d8d50c0fa90b125e0de4e4db9edf9d93a2ab6a1c7259be06dc96a76cf846154a1f7ead056becdb1a"} 07:51:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:51:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:51:43 INFO - Contents: 07:51:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/018307ef4ac58500521f3f834307566fd64e1f173df0ed3e38d132a59e4b67e0a8e4748e89da7aa9165ce0c75f0c6a3a316a8a8093dee95c1ebad24706c56c5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af4430e95b93cd06549140f34275bad679a2a7950752d110d8d50c0fa90b125e0de4e4db9edf9d93a2ab6a1c7259be06dc96a76cf846154a1f7ead056becdb1a"} 07:51:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:43 INFO - Copying logs to upload dir... 07:51:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:51:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.939082 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-09 07:51:41.979149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 07:51:41.982663) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/018307ef4ac58500521f3f834307566fd64e1f173df0ed3e38d132a59e4b67e0a8e4748e89da7aa9165ce0c75f0c6a3a316a8a8093dee95c1ebad24706c56c5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af4430e95b93cd06549140f34275bad679a2a7950752d110d8d50c0fa90b125e0de4e4db9edf9d93a2ab6a1c7259be06dc96a76cf846154a1f7ead056becdb1a"} build_url:https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011502 build_url: 'https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/018307ef4ac58500521f3f834307566fd64e1f173df0ed3e38d132a59e4b67e0a8e4748e89da7aa9165ce0c75f0c6a3a316a8a8093dee95c1ebad24706c56c5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af4430e95b93cd06549140f34275bad679a2a7950752d110d8d50c0fa90b125e0de4e4db9edf9d93a2ab6a1c7259be06dc96a76cf846154a1f7ead056becdb1a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 07:51:42.007121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:51:42.007619) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457537468.812901-873411853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:51:42.092052) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 07:51:42.092378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 07:51:42.092685) ========= ========= Total master_lag: 0.28 =========