builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1458275657.77 results: success (0) buildid: 20160317190233 builduid: f3bc7f9b25f94918b32f6e2f84e479d9 revision: 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.766687) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.767217) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.767554) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006044 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.794385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.795007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.822406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.823321) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032079 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.876828) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.877464) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.877838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:17.878481) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 21:34:17-- 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% 36.1M=0s 2016-03-17 21:34:17 (36.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171131 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:18.066384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:18.066769) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.102996 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:18.183419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:18.184220) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 --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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 21:34:18,176 truncating revision to first 12 chars 2016-03-17 21:34:18,176 Setting DEBUG logging. 2016-03-17 21:34:18,176 attempt 1/10 2016-03-17 21:34:18,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7f0c41c49f0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 21:34:18,682 unpacking tar archive at: mozilla-aurora-7f0c41c49f0e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798383 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:18.999794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:19.000761) ========= echo 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7f0c41c49f0e359e27d18016665dbe2b95fd13f7'] 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 program finished with exit code 0 elapsedTime=0.004553 script_repo_revision: '7f0c41c49f0e359e27d18016665dbe2b95fd13f7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:19.056459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:19.056829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 21:34:19.067507) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-17 21:34:19.068247) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:19 INFO - MultiFileLogger online at 20160317 21:34:19 in /builds/slave/test-pgo 21:34:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:34:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:34:19 INFO - {'append_to_log': False, 21:34:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:34:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:34:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:34:19 INFO - 'branch': 'Mozilla-Aurora', 21:34:19 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:19 INFO - 'config_files': ('talos/linux_config.py',), 21:34:19 INFO - 'default_actions': ('clobber', 21:34:19 INFO - 'read-buildbot-config', 21:34:19 INFO - 'download-and-extract', 21:34:19 INFO - 'populate-webroot', 21:34:19 INFO - 'create-virtualenv', 21:34:19 INFO - 'install', 21:34:19 INFO - 'run-tests'), 21:34:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:19 INFO - 'download_minidump_stackwalk': True, 21:34:19 INFO - 'download_symbols': 'ondemand', 21:34:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:19 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:19 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:19 INFO - 'installer_path': 'installer.exe', 21:34:19 INFO - 'log_level': 'info', 21:34:19 INFO - 'log_name': 'talos', 21:34:19 INFO - 'log_to_console': True, 21:34:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:19 INFO - 'opt_config_files': (), 21:34:19 INFO - 'pip_index': False, 21:34:19 INFO - 'sps_profile': False, 21:34:19 INFO - 'sps_profile_interval': 0, 21:34:19 INFO - 'suite': 'dromaeojs', 21:34:19 INFO - 'system_bits': '32', 21:34:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:19 INFO - 'title': 'talos-linux64-ix-061', 21:34:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:19 INFO - 'use_talos_json': True, 21:34:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:34:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:19 INFO - 'work_dir': 'build'} 21:34:19 INFO - ##### 21:34:19 INFO - ##### Running clobber step. 21:34:19 INFO - ##### 21:34:19 INFO - Running pre-action listener: _resource_record_pre_action 21:34:19 INFO - Running main action method: clobber 21:34:19 INFO - rmtree: /builds/slave/test-pgo/build 21:34:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:34:20 INFO - Running post-action listener: _resource_record_post_action 21:34:20 INFO - ##### 21:34:20 INFO - ##### Running read-buildbot-config step. 21:34:20 INFO - ##### 21:34:20 INFO - Running pre-action listener: _resource_record_pre_action 21:34:20 INFO - Running main action method: read_buildbot_config 21:34:20 INFO - Using buildbot properties: 21:34:20 INFO - { 21:34:20 INFO - "project": "", 21:34:20 INFO - "product": "firefox", 21:34:20 INFO - "script_repo_revision": "production", 21:34:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:34:20 INFO - "repository": "", 21:34:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:34:20 INFO - "buildid": "20160317190233", 21:34:20 INFO - "pgo_build": "True", 21:34:20 INFO - "basedir": "/builds/slave/test-pgo", 21:34:20 INFO - "buildnumber": 119, 21:34:20 INFO - "slavename": "talos-linux64-ix-061", 21:34:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:34:20 INFO - "platform": "ubuntu64_hw", 21:34:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:34:20 INFO - "branch": "mozilla-aurora", 21:34:20 INFO - "repo_path": "releases/mozilla-aurora", 21:34:20 INFO - "revision": "7f0c41c49f0e359e27d18016665dbe2b95fd13f7", 21:34:20 INFO - "stage_platform": "linux64-pgo", 21:34:20 INFO - "builduid": "f3bc7f9b25f94918b32f6e2f84e479d9", 21:34:20 INFO - "slavebuilddir": "test" 21:34:20 INFO - } 21:34:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 21:34:20 INFO - Running post-action listener: _resource_record_post_action 21:34:20 INFO - ##### 21:34:20 INFO - ##### Running download-and-extract step. 21:34:20 INFO - ##### 21:34:20 INFO - Running pre-action listener: _resource_record_pre_action 21:34:20 INFO - Running main action method: download_and_extract 21:34:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:34:20 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')]} 21:34:20 INFO - https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:34:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 21:34:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 21:34:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 21:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:34:21 INFO - Downloaded 1448 bytes. 21:34:21 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 21:34:21 INFO - Using the following test package requirements: 21:34:21 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:21 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:34:21 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:34:21 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'jsshell-linux-x86_64.zip'], 21:34:21 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:34:21 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:21 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:34:21 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:34:21 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:34:21 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 21:34:21 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 21:34:21 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:34:21 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:21 INFO - https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 21:34:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 21:34:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 21:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:22 INFO - Downloaded 23309070 bytes. 21:34:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:34:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:34:23 INFO - Return code: 0 21:34:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:23 INFO - https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 21:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 21:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 21:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:24 INFO - Downloaded 23309070 bytes. 21:34:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:34:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:34:26 INFO - Return code: 0 21:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:26 INFO - https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:34:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 21:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:34:27 INFO - Downloaded 10845161 bytes. 21:34:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:34:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:34:28 INFO - Return code: 0 21:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:28 INFO - https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 21:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 21:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 21:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:34:29 INFO - Downloaded 60444334 bytes. 21:34:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 21:34:29 INFO - mkdir: /builds/slave/test-pgo/properties 21:34:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:34:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:34:29 INFO - Contents: 21:34:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 21:34:30 INFO - Running post-action listener: _resource_record_post_action 21:34:30 INFO - Running post-action listener: set_extra_try_arguments 21:34:30 INFO - ##### 21:34:30 INFO - ##### Running populate-webroot step. 21:34:30 INFO - ##### 21:34:30 INFO - Running pre-action listener: _resource_record_pre_action 21:34:30 INFO - Running main action method: populate_webroot 21:34:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:30 INFO - '--tppagecycles', 21:34:30 INFO - '7'], 21:34:30 INFO - 'tests': ['tsvgm']}}, 21:34:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:34:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:34:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:34:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'tests': ['damp', 'tps']}, 21:34:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['damp', 'tps']}, 21:34:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:34:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:30 INFO - 'other': {'tests': ['a11yr', 21:34:30 INFO - 'ts_paint', 21:34:30 INFO - 'tpaint', 21:34:30 INFO - 'sessionrestore', 21:34:30 INFO - 'sessionrestore_no_auto_restore', 21:34:30 INFO - 'tabpaint']}, 21:34:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['a11yr', 21:34:30 INFO - 'ts_paint', 21:34:30 INFO - 'tpaint', 21:34:30 INFO - 'sessionrestore', 21:34:30 INFO - 'sessionrestore_no_auto_restore', 21:34:30 INFO - 'tabpaint']}, 21:34:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['a11yr', 21:34:30 INFO - 'ts_paint', 21:34:30 INFO - 'tpaint', 21:34:30 INFO - 'sessionrestore', 21:34:30 INFO - 'sessionrestore_no_auto_restore', 21:34:30 INFO - 'tabpaint']}, 21:34:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['a11yr', 21:34:30 INFO - 'ts_paint', 21:34:30 INFO - 'tpaint', 21:34:30 INFO - 'sessionrestore', 21:34:30 INFO - 'sessionrestore_no_auto_restore', 21:34:30 INFO - 'tabpaint']}, 21:34:30 INFO - 'other_l64': {'tests': ['a11yr', 21:34:30 INFO - 'ts_paint', 21:34:30 INFO - 'tpaint', 21:34:30 INFO - 'sessionrestore', 21:34:30 INFO - 'sessionrestore_no_auto_restore', 21:34:30 INFO - 'tabpaint']}, 21:34:30 INFO - 'other_nol64': {'tests': ['a11yr', 21:34:30 INFO - 'ts_paint', 21:34:30 INFO - 'tpaint', 21:34:30 INFO - 'sessionrestore', 21:34:30 INFO - 'sessionrestore_no_auto_restore', 21:34:30 INFO - 'tabpaint']}, 21:34:30 INFO - 'svgr': {'tests': ['tsvgx', 21:34:30 INFO - 'tsvgr_opacity', 21:34:30 INFO - 'tart', 21:34:30 INFO - 'tscrollx', 21:34:30 INFO - 'cart']}, 21:34:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['tsvgx', 21:34:30 INFO - 'tsvgr_opacity', 21:34:30 INFO - 'tart', 21:34:30 INFO - 'tscrollx', 21:34:30 INFO - 'cart']}, 21:34:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'tests': ['tp5o']}, 21:34:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'talos_options': ['--e10s'], 21:34:30 INFO - 'tests': ['tp5o']}, 21:34:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'talos_options': ['--xperf_path', 21:34:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:30 INFO - 'tests': ['tp5n']}, 21:34:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:30 INFO - 'talos_options': ['--e10s', 21:34:30 INFO - '--xperf_path', 21:34:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:30 INFO - 'tests': ['tp5n']}}, 21:34:30 INFO - 'talos.zip': {'path': '', 21:34:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:30 INFO - Running post-action listener: _resource_record_post_action 21:34:30 INFO - ##### 21:34:30 INFO - ##### Running create-virtualenv step. 21:34:30 INFO - ##### 21:34:30 INFO - Running pre-action listener: _resource_record_pre_action 21:34:30 INFO - Running main action method: create_virtualenv 21:34:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:34:30 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 21:34:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:34:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:30 INFO - Using real prefix '/usr' 21:34:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:34:31 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:33 INFO - Installing pip.................done. 21:34:33 INFO - Return code: 0 21:34:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:34: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')]} 21:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34: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')]} 21:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:33 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:33 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 21:34:33 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 21:34:33 INFO - Using env: {'DISPLAY': ':0', 21:34:33 INFO - 'HOME': '/home/cltbld', 21:34:33 INFO - 'LANG': 'en_US.UTF-8', 21:34:33 INFO - 'LANGUAGE': 'en_US:en', 21:34:33 INFO - 'LOGNAME': 'cltbld', 21:34:33 INFO - 'MAIL': '/var/mail/cltbld', 21:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:33 INFO - 'MOZ_NO_REMOTE': '1', 21:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:33 INFO - 'NO_EM_RESTART': '1', 21:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:33 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:33 INFO - 'SHELL': '/bin/bash', 21:34:33 INFO - 'SHLVL': '1', 21:34:33 INFO - 'TERM': 'linux', 21:34:33 INFO - 'TMOUT': '86400', 21:34:33 INFO - 'USER': 'cltbld', 21:34:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:33 INFO - '_': '/tools/buildbot/bin/python'} 21:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:35 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 21:34:35 INFO - Cleaning up... 21:34:35 INFO - Return code: 0 21:34:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:34:35 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')]} 21:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:35 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')]} 21:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:35 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:35 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 21:34:35 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 21:34:35 INFO - Using env: {'DISPLAY': ':0', 21:34:35 INFO - 'HOME': '/home/cltbld', 21:34:35 INFO - 'LANG': 'en_US.UTF-8', 21:34:35 INFO - 'LANGUAGE': 'en_US:en', 21:34:35 INFO - 'LOGNAME': 'cltbld', 21:34:35 INFO - 'MAIL': '/var/mail/cltbld', 21:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:35 INFO - 'MOZ_NO_REMOTE': '1', 21:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:35 INFO - 'NO_EM_RESTART': '1', 21:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:35 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:35 INFO - 'SHELL': '/bin/bash', 21:34:35 INFO - 'SHLVL': '1', 21:34:35 INFO - 'TERM': 'linux', 21:34:35 INFO - 'TMOUT': '86400', 21:34:35 INFO - 'USER': 'cltbld', 21:34:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:35 INFO - '_': '/tools/buildbot/bin/python'} 21:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:35 INFO - Downloading/unpacking psutil>=0.7.1 21:34:35 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 21:34:35 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 21:34:35 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 21:34:35 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 21:34:35 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 21:34:35 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 21:34:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:37 INFO - Installing collected packages: psutil 21:34:37 INFO - Running setup.py install for psutil 21:34:37 INFO - building 'psutil._psutil_linux' extension 21:34:37 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 21:34:38 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 21:34:38 INFO - building 'psutil._psutil_posix' extension 21:34:38 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 21:34:38 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 21:34:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:38 INFO - Successfully installed psutil 21:34:38 INFO - Cleaning up... 21:34:38 INFO - Return code: 0 21:34:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:34:38 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')]} 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:38 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')]} 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:38 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:38 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 21:34:38 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 21:34:38 INFO - Using env: {'DISPLAY': ':0', 21:34:38 INFO - 'HOME': '/home/cltbld', 21:34:38 INFO - 'LANG': 'en_US.UTF-8', 21:34:38 INFO - 'LANGUAGE': 'en_US:en', 21:34:38 INFO - 'LOGNAME': 'cltbld', 21:34:38 INFO - 'MAIL': '/var/mail/cltbld', 21:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:38 INFO - 'MOZ_NO_REMOTE': '1', 21:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:38 INFO - 'NO_EM_RESTART': '1', 21:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:38 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:38 INFO - 'SHELL': '/bin/bash', 21:34:38 INFO - 'SHLVL': '1', 21:34:38 INFO - 'TERM': 'linux', 21:34:38 INFO - 'TMOUT': '86400', 21:34:38 INFO - 'USER': 'cltbld', 21:34:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:38 INFO - '_': '/tools/buildbot/bin/python'} 21:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:34:39 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 21:34:39 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 21:34:39 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 21:34:39 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 21:34:39 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 21:34:39 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 21:34:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:34:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:34:41 INFO - Installing collected packages: mozsystemmonitor 21:34:41 INFO - Running setup.py install for mozsystemmonitor 21:34:41 INFO - Successfully installed mozsystemmonitor 21:34:41 INFO - Cleaning up... 21:34:41 INFO - Return code: 0 21:34:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:34:41 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')]} 21:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:41 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')]} 21:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:41 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:41 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 21:34:41 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 21:34:41 INFO - Using env: {'DISPLAY': ':0', 21:34:41 INFO - 'HOME': '/home/cltbld', 21:34:41 INFO - 'LANG': 'en_US.UTF-8', 21:34:41 INFO - 'LANGUAGE': 'en_US:en', 21:34:41 INFO - 'LOGNAME': 'cltbld', 21:34:41 INFO - 'MAIL': '/var/mail/cltbld', 21:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:41 INFO - 'MOZ_NO_REMOTE': '1', 21:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:41 INFO - 'NO_EM_RESTART': '1', 21:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:41 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:41 INFO - 'SHELL': '/bin/bash', 21:34:41 INFO - 'SHLVL': '1', 21:34:41 INFO - 'TERM': 'linux', 21:34:41 INFO - 'TMOUT': '86400', 21:34:41 INFO - 'USER': 'cltbld', 21:34:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:41 INFO - '_': '/tools/buildbot/bin/python'} 21:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:41 INFO - Downloading/unpacking blobuploader==1.2.4 21:34:41 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 21:34:41 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 21:34:41 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 21:34:41 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 21:34:41 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 21:34:41 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 21:34:43 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:34:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:43 INFO - Downloading docopt-0.6.1.tar.gz 21:34:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:44 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:44 INFO - Running setup.py install for blobuploader 21:34:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:34:44 INFO - Running setup.py install for requests 21:34:44 INFO - Running setup.py install for docopt 21:34:44 INFO - Successfully installed blobuploader requests docopt 21:34:44 INFO - Cleaning up... 21:34:44 INFO - Return code: 0 21:34:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:44 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:44 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 21:34:44 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 21:34:44 INFO - Using env: {'DISPLAY': ':0', 21:34:44 INFO - 'HOME': '/home/cltbld', 21:34:44 INFO - 'LANG': 'en_US.UTF-8', 21:34:44 INFO - 'LANGUAGE': 'en_US:en', 21:34:44 INFO - 'LOGNAME': 'cltbld', 21:34:44 INFO - 'MAIL': '/var/mail/cltbld', 21:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:44 INFO - 'MOZ_NO_REMOTE': '1', 21:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:44 INFO - 'NO_EM_RESTART': '1', 21:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:44 INFO - 'SHELL': '/bin/bash', 21:34:44 INFO - 'SHLVL': '1', 21:34:44 INFO - 'TERM': 'linux', 21:34:44 INFO - 'TMOUT': '86400', 21:34:44 INFO - 'USER': 'cltbld', 21:34:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:44 INFO - '_': '/tools/buildbot/bin/python'} 21:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:44 INFO - Running setup.py (path:/tmp/pip-OJqWmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:44 INFO - Running setup.py (path:/tmp/pip-og6HIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:44 INFO - Running setup.py (path:/tmp/pip-JbOWvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:45 INFO - Running setup.py (path:/tmp/pip-Ce3hqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:45 INFO - Running setup.py (path:/tmp/pip-6vWhgb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:45 INFO - Running setup.py (path:/tmp/pip-OEEI91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:45 INFO - Running setup.py (path:/tmp/pip-stR9pZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:45 INFO - Running setup.py (path:/tmp/pip-aEwXvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:45 INFO - Running setup.py (path:/tmp/pip-OsQgIg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:45 INFO - Running setup.py (path:/tmp/pip-qB1WhD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:45 INFO - Running setup.py (path:/tmp/pip-mWxMZa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:45 INFO - Running setup.py (path:/tmp/pip-o9nVio-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:45 INFO - Running setup.py (path:/tmp/pip-lkpRzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:45 INFO - Running setup.py (path:/tmp/pip-u2L3U4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:45 INFO - Running setup.py (path:/tmp/pip-AKVof_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:45 INFO - Running setup.py (path:/tmp/pip-kyCPFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:46 INFO - Running setup.py (path:/tmp/pip-qXACST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:34:46 INFO - Running setup.py install for manifestparser 21:34:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Running setup.py install for mozcrash 21:34:46 INFO - Running setup.py install for mozdebug 21:34:46 INFO - Running setup.py install for mozdevice 21:34:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Running setup.py install for mozfile 21:34:46 INFO - Running setup.py install for mozhttpd 21:34:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Running setup.py install for mozinfo 21:34:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Running setup.py install for mozInstall 21:34:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:34:46 INFO - Running setup.py install for mozleak 21:34:46 INFO - Running setup.py install for mozlog 21:34:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Running setup.py install for moznetwork 21:34:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Running setup.py install for mozprocess 21:34:47 INFO - Running setup.py install for mozprofile 21:34:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Running setup.py install for mozrunner 21:34:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Running setup.py install for mozscreenshot 21:34:47 INFO - Running setup.py install for moztest 21:34:47 INFO - Running setup.py install for mozversion 21:34:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:34:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:47 INFO - Cleaning up... 21:34:47 INFO - Return code: 0 21:34:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:47 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:47 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 21:34:47 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 21:34:47 INFO - Using env: {'DISPLAY': ':0', 21:34:47 INFO - 'HOME': '/home/cltbld', 21:34:47 INFO - 'LANG': 'en_US.UTF-8', 21:34:47 INFO - 'LANGUAGE': 'en_US:en', 21:34:47 INFO - 'LOGNAME': 'cltbld', 21:34:47 INFO - 'MAIL': '/var/mail/cltbld', 21:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:47 INFO - 'MOZ_NO_REMOTE': '1', 21:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:47 INFO - 'NO_EM_RESTART': '1', 21:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:47 INFO - 'SHELL': '/bin/bash', 21:34:47 INFO - 'SHLVL': '1', 21:34:47 INFO - 'TERM': 'linux', 21:34:47 INFO - 'TMOUT': '86400', 21:34:47 INFO - 'USER': 'cltbld', 21:34:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:47 INFO - '_': '/tools/buildbot/bin/python'} 21:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:48 INFO - Running setup.py (path:/tmp/pip-Xe_A4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:48 INFO - Running setup.py (path:/tmp/pip-6RJjF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:48 INFO - Running setup.py (path:/tmp/pip-4en4oX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:48 INFO - Running setup.py (path:/tmp/pip-SwFLR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:48 INFO - Running setup.py (path:/tmp/pip-Zv6xaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:48 INFO - Running setup.py (path:/tmp/pip-eA6Qoz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:48 INFO - Running setup.py (path:/tmp/pip-MCpRK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:48 INFO - Running setup.py (path:/tmp/pip-ri6h_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:48 INFO - Running setup.py (path:/tmp/pip-En_bEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:48 INFO - Running setup.py (path:/tmp/pip-n1waGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:48 INFO - Running setup.py (path:/tmp/pip-lz6tIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:48 INFO - Running setup.py (path:/tmp/pip-UW6hdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:34:48 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)) 21:34:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:48 INFO - Running setup.py (path:/tmp/pip-bcYNVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:34:49 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)) 21:34:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:49 INFO - Running setup.py (path:/tmp/pip-E_8OJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:34:49 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)) 21:34:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:49 INFO - Running setup.py (path:/tmp/pip-wPiA9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:34:49 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)) 21:34:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:49 INFO - Running setup.py (path:/tmp/pip-QoRrRv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:34:49 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)) 21:34:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:49 INFO - Running setup.py (path:/tmp/pip-87IR84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:34:49 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)) 21:34:49 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)) 21:34:49 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)) 21:34:49 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)) 21:34:49 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)) 21:34:49 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)) 21:34:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:51 INFO - Downloading blessings-1.6.tar.gz 21:34:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:51 INFO - Installing collected packages: blessings 21:34:51 INFO - Running setup.py install for blessings 21:34:51 INFO - Successfully installed blessings 21:34:51 INFO - Cleaning up... 21:34:51 INFO - Return code: 0 21:34:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:34:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:34:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:34:51 INFO - Reading from file tmpfile_stdout 21:34:51 INFO - Current package versions: 21:34:51 INFO - argparse == 1.2.1 21:34:51 INFO - blessings == 1.6 21:34:51 INFO - blobuploader == 1.2.4 21:34:51 INFO - docopt == 0.6.1 21:34:51 INFO - manifestparser == 1.1 21:34:51 INFO - mozInstall == 1.12 21:34:51 INFO - mozcrash == 0.17 21:34:51 INFO - mozdebug == 0.1 21:34:51 INFO - mozdevice == 0.48 21:34:51 INFO - mozfile == 1.2 21:34:51 INFO - mozhttpd == 0.7 21:34:51 INFO - mozinfo == 0.9 21:34:51 INFO - mozleak == 0.1 21:34:51 INFO - mozlog == 3.1 21:34:51 INFO - moznetwork == 0.27 21:34:51 INFO - mozprocess == 0.22 21:34:51 INFO - mozprofile == 0.28 21:34:51 INFO - mozrunner == 6.11 21:34:51 INFO - mozscreenshot == 0.1 21:34:51 INFO - mozsystemmonitor == 0.0 21:34:51 INFO - moztest == 0.7 21:34:51 INFO - mozversion == 1.4 21:34:51 INFO - psutil == 3.1.1 21:34:51 INFO - requests == 1.2.3 21:34:51 INFO - wsgiref == 0.1.2 21:34:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:34:51 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')]} 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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')]} 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:51 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 21:34:51 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 21:34:51 INFO - Using env: {'DISPLAY': ':0', 21:34:51 INFO - 'HOME': '/home/cltbld', 21:34:51 INFO - 'LANG': 'en_US.UTF-8', 21:34:51 INFO - 'LANGUAGE': 'en_US:en', 21:34:51 INFO - 'LOGNAME': 'cltbld', 21:34:51 INFO - 'MAIL': '/var/mail/cltbld', 21:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:51 INFO - 'MOZ_NO_REMOTE': '1', 21:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:51 INFO - 'NO_EM_RESTART': '1', 21:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:51 INFO - 'SHELL': '/bin/bash', 21:34:51 INFO - 'SHLVL': '1', 21:34:51 INFO - 'TERM': 'linux', 21:34:51 INFO - 'TMOUT': '86400', 21:34:51 INFO - 'USER': 'cltbld', 21:34:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:51 INFO - '_': '/tools/buildbot/bin/python'} 21:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 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)) 21:34:51 INFO - Cleaning up... 21:34:51 INFO - Return code: 0 21:34:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:34:51 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')]} 21:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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')]} 21:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:51 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:51 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 21:34:51 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 21:34:51 INFO - Using env: {'DISPLAY': ':0', 21:34:51 INFO - 'HOME': '/home/cltbld', 21:34:51 INFO - 'LANG': 'en_US.UTF-8', 21:34:51 INFO - 'LANGUAGE': 'en_US:en', 21:34:51 INFO - 'LOGNAME': 'cltbld', 21:34:51 INFO - 'MAIL': '/var/mail/cltbld', 21:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:51 INFO - 'MOZ_NO_REMOTE': '1', 21:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:51 INFO - 'NO_EM_RESTART': '1', 21:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:51 INFO - 'SHELL': '/bin/bash', 21:34:51 INFO - 'SHLVL': '1', 21:34:51 INFO - 'TERM': 'linux', 21:34:51 INFO - 'TMOUT': '86400', 21:34:51 INFO - 'USER': 'cltbld', 21:34:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:51 INFO - '_': '/tools/buildbot/bin/python'} 21:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:52 INFO - Downloading/unpacking jsonschema 21:34:52 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 21:34:52 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 21:34:52 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 21:34:52 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 21:34:52 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 21:34:52 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 21:34:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:53 INFO - Downloading/unpacking functools32 (from jsonschema) 21:34:53 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 21:34:53 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 21:34:53 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 21:34:53 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 21:34:53 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 21:34:53 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 21:34:54 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:34:54 INFO - warning: no files found matching '*.txt' 21:34:54 INFO - no previously-included directories found matching 'build' 21:34:54 INFO - no previously-included directories found matching 'dist' 21:34:54 INFO - no previously-included directories found matching '.git*' 21:34:54 INFO - Installing collected packages: jsonschema, functools32 21:34:54 INFO - Running setup.py install for functools32 21:34:54 INFO - warning: no files found matching '*.txt' 21:34:54 INFO - no previously-included directories found matching 'build' 21:34:54 INFO - no previously-included directories found matching 'dist' 21:34:54 INFO - no previously-included directories found matching '.git*' 21:34:54 INFO - Successfully installed jsonschema functools32 21:34:54 INFO - Cleaning up... 21:34:54 INFO - Return code: 0 21:34:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:34:54 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')]} 21:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:54 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')]} 21:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:54 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 0x7f04ea427f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', '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 21:34:54 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 21:34:54 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 21:34:54 INFO - Using env: {'DISPLAY': ':0', 21:34:54 INFO - 'HOME': '/home/cltbld', 21:34:54 INFO - 'LANG': 'en_US.UTF-8', 21:34:54 INFO - 'LANGUAGE': 'en_US:en', 21:34:54 INFO - 'LOGNAME': 'cltbld', 21:34:54 INFO - 'MAIL': '/var/mail/cltbld', 21:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:54 INFO - 'MOZ_NO_REMOTE': '1', 21:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:54 INFO - 'NO_EM_RESTART': '1', 21:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:34:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:34:54 INFO - 'SHELL': '/bin/bash', 21:34:54 INFO - 'SHLVL': '1', 21:34:54 INFO - 'TERM': 'linux', 21:34:54 INFO - 'TMOUT': '86400', 21:34:54 INFO - 'USER': 'cltbld', 21:34:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:54 INFO - '_': '/tools/buildbot/bin/python'} 21:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:54 INFO - Downloading/unpacking flake8 21:34:54 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 21:34:54 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 21:34:54 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 21:34:54 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 21:34:54 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 21:34:54 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 21:34:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:34:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:34:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:56 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 21:34:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:34:57 INFO - no previously-included directories found matching 'docs/_build' 21:34:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:34:57 INFO - Running setup.py install for pep8 21:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:34:57 INFO - no previously-included directories found matching 'docs/_build' 21:34:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:34:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:34:57 INFO - Cleaning up... 21:34:57 INFO - Return code: 0 21:34:57 INFO - Running post-action listener: _resource_record_post_action 21:34:57 INFO - Running post-action listener: _start_resource_monitoring 21:34:57 INFO - Starting resource monitoring. 21:34:57 INFO - ##### 21:34:57 INFO - ##### Running install step. 21:34:57 INFO - ##### 21:34:57 INFO - Running pre-action listener: _resource_record_pre_action 21:34:57 INFO - Running main action method: install 21:34:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:34:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:34:57 INFO - Reading from file tmpfile_stdout 21:34:57 INFO - Detecting whether we're running mozinstall >=1.0... 21:34:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:34:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:34:57 INFO - Reading from file tmpfile_stdout 21:34:57 INFO - Output received: 21:34:57 INFO - Usage: mozinstall [options] installer 21:34:57 INFO - Options: 21:34:57 INFO - -h, --help show this help message and exit 21:34:57 INFO - -d DEST, --destination=DEST 21:34:57 INFO - Directory to install application into. [default: 21:34:57 INFO - "/builds/slave/test-pgo"] 21:34:57 INFO - --app=APP Application being installed. [default: firefox] 21:34:57 INFO - mkdir: /builds/slave/test-pgo/build/application 21:34:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:34:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:35:12 INFO - Reading from file tmpfile_stdout 21:35:12 INFO - Output received: 21:35:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:35:12 INFO - Running post-action listener: _resource_record_post_action 21:35:12 INFO - ##### 21:35:12 INFO - ##### Running run-tests step. 21:35:12 INFO - ##### 21:35:12 INFO - Running pre-action listener: _resource_record_pre_action 21:35:12 INFO - Running main action method: run_tests 21:35:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:35:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:35:12 INFO - Python 2.7.3 21:35:12 INFO - Return code: 0 21:35:12 INFO - grabbing minidump binary from tooltool 21:35: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')]} 21:35:12 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 0x2a79920>, '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 0x2a7a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7acb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:35:12 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 21:35:12 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 21:35:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:13 INFO - Return code: 0 21:35:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:35:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:35:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:35:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:35:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:35:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:35:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:35:14 INFO - Return code: 0 21:35:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:35:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 21:35:14 INFO - Using env: {'DISPLAY': ':0', 21:35:14 INFO - 'HOME': '/home/cltbld', 21:35:14 INFO - 'LANG': 'en_US.UTF-8', 21:35:14 INFO - 'LANGUAGE': 'en_US:en', 21:35:14 INFO - 'LOGNAME': 'cltbld', 21:35:14 INFO - 'MAIL': '/var/mail/cltbld', 21:35:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:35:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:14 INFO - 'MOZ_NO_REMOTE': '1', 21:35:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:14 INFO - 'NO_EM_RESTART': '1', 21:35:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:35:14 INFO - 'PWD': '/builds/slave/test-pgo', 21:35:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:35:14 INFO - 'SHELL': '/bin/bash', 21:35:14 INFO - 'SHLVL': '1', 21:35:14 INFO - 'TERM': 'linux', 21:35:14 INFO - 'TMOUT': '86400', 21:35:14 INFO - 'USER': 'cltbld', 21:35:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550', 21:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:14 INFO - '_': '/tools/buildbot/bin/python'} 21:35:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:35:14 INFO - mozversion application_buildid: 20160317190233 21:35:14 INFO - mozversion application_changeset: 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 21:35:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:35:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:14 INFO - mozversion application_name: Firefox 21:35:14 INFO - mozversion application_remotingname: firefox-dev 21:35:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:35:14 INFO - mozversion application_vendor: Mozilla 21:35:14 INFO - mozversion application_version: 47.0a2 21:35:14 INFO - mozversion platform_buildid: 20160317190233 21:35:14 INFO - mozversion platform_changeset: 7f0c41c49f0e359e27d18016665dbe2b95fd13f7 21:35:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:35:14 INFO - mozversion platform_version: 47.0a2 21:35:14 INFO - using testdate: 1458275714 21:35:14 INFO - actual date: 1458275714 21:35:14 INFO - starting webserver on 'localhost:49658' 21:35:14 INFO - SUITE-START | Running 2 tests 21:35:14 INFO - TEST-START | dromaeo_css 21:35:14 INFO - operating with platform_type : linux_ 21:35:14 INFO - Initialising browser for dromaeo_css test... 21:35:14 INFO - TEST-INFO | started process 3319 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUYJAYD/profile http://localhost:49658/getInfo.html) 21:35:19 INFO - PROCESS | 3319 | __metrics Screen width/height:1600/1200 21:35:19 INFO - PROCESS | 3319 | colorDepth:24 21:35:19 INFO - PROCESS | 3319 | Browser inner width/height: 1024/697 21:35:19 INFO - PROCESS | 3319 | __metrics 21:35:20 INFO - PROCESS | 3319 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:21 INFO - TEST-INFO | 3319: exit 0 21:35:21 INFO - Browser initialized. 21:35:21 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:21 INFO - TEST-INFO | started process 3409 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUYJAYD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:32 INFO - PROCESS | 3409 | RSS: Main: 144916480 21:35:32 INFO - PROCESS | 3409 | 21:36:23 INFO - PROCESS | 3409 | 1458275783576 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] 21:38:31 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:49658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49658/tests/dromaeo/cssquery-ext.html) 21:38:32 INFO - PROCESS | 3409 | RSS: Main: 248520704 21:38:32 INFO - PROCESS | 3409 | 21:41:34 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:49658/tests/dromaeo/cssquery-ext.html (next: http://localhost:49658/tests/dromaeo/cssquery-jquery.html) 21:41:35 INFO - PROCESS | 3409 | RSS: Main: 225562624 21:41:35 INFO - PROCESS | 3409 | 21:44:37 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:49658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49658/tests/dromaeo/cssquery-mootools.html) 21:44:37 INFO - PROCESS | 3409 | RSS: Main: 217444352 21:44:37 INFO - PROCESS | 3409 | 21:47:39 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:49658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49658/tests/dromaeo/cssquery-prototype.html) 21:47:40 INFO - PROCESS | 3409 | RSS: Main: 209035264 21:47:40 INFO - PROCESS | 3409 | 21:50:42 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:49658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49658/tests/dromaeo/cssquery-yui.html) 21:50:43 INFO - PROCESS | 3409 | RSS: Main: 211521536 21:50:43 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:49658/tests/dromaeo/cssquery-yui.html (next: http://localhost:49658/tests/dromaeo/cssquery-dojo.html) 21:53:45 INFO - PROCESS | 3409 | RSS: Main: 257662976 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | __start_tp_report 21:53:45 INFO - PROCESS | 3409 | _x_x_mozilla_page_load 21:53:45 INFO - PROCESS | 3409 | _x_x_mozilla_page_load_details 21:53:45 INFO - PROCESS | 3409 | |i|pagename|runs| 21:53:45 INFO - PROCESS | 3409 | |0;dojo.html;3211.7751757376986;3273.6889995450424;3303.834808259586;3311.5694959655243;3337.265801523665;5285.471452854717;5304.469553044699;5322.068637988346;5323.520883120518;5383.273258110159;5314.548263397606;5318.494742999418;5345.572354211664;5355.464453554642;5362.3029006229135;4698.083873644624;4886.926696099561;4898.779554920028;4938.2098864181735;4968.453470118284;4734.266188740734;4780.450248221447;4809.807607695706;4863.489333619972;4864.367632207808;4816.277558366256;4864.173090574611;4877.756112194394;4894.437139728923;4937.407511098673;4831.4685384607665;4846.733429661367;4858.708477491362;4859.295402166684;4862.854114376574;4734.053189362141;4781.306710526989;4793.137235297645;4853.733044682541;4888.120138375091;5157.742112894378;5158.845234642929;5163.535281824654;5168.2764412982215;5193.1171700810955;5650.943490565124;5655.547556195535;5660.688662123582;5664.461876121762;5697.287839020122;5517.44825517449;5621.550275977953;5654;5691.573132015115;5741.167530708066;5238.292830467914;5240.895182096375;5241.764120614582;5242.449542797989;5244.816431424882;5616.971915140398;5722.341930677942;5724.227229323988;5724.799632012943;5730.455606717355;5609.439056094439;5678.772849086073;5683.460071293221;5711.914321285184;5715.228444159985;5428.131498960148;5429;5448.400675925645;5451.400345961941;5486.423925487767;5443.265159203457;5452.6183167177915;5460.6996615186545;5473.8357849264585;5517.724113794295;5647.124695672177;5648.6893220872425;5654.37801841797;5654.830355089354;5670.262865827416;4340.175366680321;4348.5216626171095;4348.673849461303;4354.847580334673;4373.759443230653;3796.8671096512044;3899.7855117968215;3942.329803933338;3944.36890097583;3976.025873660914;5193.246979188072;5214.530692237641;5226.242194881721;5260.368755749258;5318.627696061316;5657.717114144276;5668.064769313017;5670.858228544237;5675.404082571271;5682.460166284196;5100;5246.947530524722;5339.0389729849;5392.137258038695;5420.07858664028;4845.248986407042;4849.854504364875;4854.490278520775;4854.708717476963;4889.071076495455;5729.28383952006;5737.540996720252;5738.053221218535;5738.282714660668;5752.654840709571;5585.5531557476115;5600.299962504687;5695.145728140812;5789.218455508452;5795.768169273182;5787.971060144672;5833.445822646841;5834.591578589458;5836.766529338779;5841.532677385884;5600.943990560042;5629.746661400165;5631.099024156116;5640.915386269127;5649.180868774087;5511.559075273888;5644.9435505644415;5708.229389032427;5718.771249149988;5747.913781293368;5528.364238112668;5530.391656917655;5546.973809845192;5561.833145005657;5566.805161819317;5455.918161227505;5550.111982082847;5562.193481945176;5563.670626710617;5571.164325351229;5493.176023596333;5573.804916827891;5584.581156413204;5595.0208713475795;5613.550915926634;5602;5636.408177141341;5638.154276858504;5643.858903527444;5655.236543066633;5296.708681022426;5467.316585426822;5522.66863988162;5543.556515478833;5550.916736248879 21:53:45 INFO - PROCESS | 3409 | |1;ext.html;522.9189475631279;550.2241839007;555.8721494056366;564.0692856786303;596.6181643747999;31733.20666983324;32445.188870278256;41128.17743645129;41769.58230417695;41830.790846045806;44961.77519112408;45300.773496132555;45366.092678146415;45564;45620;7977.800554986143;8903.020667726561;9144.954275228614;9234.907650923506;9235.815283694323;8013.358931285483;11016.614418495354;11314.434278286093;11315.547378104866;11323.43382830855;10908.34549927003;11006.614768483065;11012.559497620086;11023.724406889853;11026.669199924016;10829.891701082966;10910.127189824794;10949.397783121925;10950.671479855617;10961.287516311455;10589.205809564237;10771.138308935266;10771.353718776898;10778.245522813328;10790.082842958358;40647.59352406468;44107.338389924174;44167.33748993768;44188.55811441877;44221.336679949825;3581.6239294874185;4057.8637981365264;4285.8499952501825;4356.6950313477755;4479.238529450001;34596.13509662254;34790.652093478995;34901;35039.64960350415;35137.648623513945;4226.978865105655;4245.87262382129;4249.787510624456;4255.446791917062;4308;249762;251045;251195.74402128055;251416;252688;63549.36450635527;63675.36324636694;63809.99999999907;64433;64494;76767.61616191884;77738.6113069431;78126;78166;78170.60914695504;16593.751093733605;16608.00351978885;16673.416430424877;16727.330906763837;16812.24344904482;11451.656450306504;12445.62663120108;12728.554500592434;12858.9357053216;12861.099723019299;21964.670529942065;22309.553808924054;22363.21728739519;22467.662985055238;22548.66177007346;8445.873311900326;8508;8538.669918731699;8594.742157735278;8704.390692651581;1064.1965316186383;1112.4604566785104;1118.7706520163347;1121;1233.9881297336099;31323.53014704781;31517.842410788257;31544;31825.363492730015;32178.35643287168;1145.8223975283845;1193.3436609864539;1216.1851559455185;1240.621610408834;1270.7712611729978;16240.269187886573;16472.588185295463;16515.58711032234;16590;17056.976581405157;369635;372272;372401;373430;374237.1288143542;61945.38054619396;62461.68769156216;62849.371506284355;62935.68532157401;62940;1360.9659758506116;1402.3479082226813;1484.9703005940037;1530.211940850463;1569.9372025118867;28093.297667558476;28241.43517129605;28272.15183544497;28801;29199.416011680074;45165.322520161564;45227;45545.54454455546;45560;45571.54428455673;197846;198809;199153;199345;199574;30815.845920770254;35405.29189416249;35563.466548001285;35618.10954726049;36437.817810910776;43211.35182972321;43987;44068.11863762642;44678.329825052;44997.77501112605;36471.63528364682;36654.450183246736;37031.62968370282;37232.81383593065;38081.61918380781;38562.421563676005;38659;39056.804715976235;39518.40722389109;39955;38918.80540597279;39128.80435597918;44467.33299000453;45541.77229113833;45553.77223113863;31864.36271274515;33429.49855752117;33434.832825835714;33571.49642755409;33713;26167.869160654074;26416.471670566865;26544.203673889813;26582.335441614116;26914.461710766067 21:53:45 INFO - PROCESS | 3409 | |2;jquery.html;370.82385866713315;389.8830350894731;392.23318412503556;392.9410588411738;400.2715058593361;17711.82288177118;19156.712649310255;19578.70631940522;19667.60664786707;19699.60600787985;17877.195526201318;17903;18501.629967400644;18535.073246337695;18769.530761730963;5631.971840140794;5781.335146458169;5783.6240644358195;5796.07262837946;5837.24115864937;4292.871213863589;5922.763089476416;6369.968150159243;6380.361963803629;6393.136926514908;6290.811275661715;6321.841953951142;6335.778247761329;6344.460720838734;6349.968250158766;6233.625982441068;6334.714937827809;6341.778037768679;6379.393957574023;6395.552311338208;3898.142408670088;5308.575313974873;5473.67157970523;5483.506484416422;5485.314335708036;21762.673559896615;21963.23128690504;22140.446488837748;22258.332250032527;22267.44331391712;2332.8367014309006;2390.581648211556;2420;2449.448874003335;2554.885030173628;13734.65663358424;13885.166889986633;13987;14066.2966851657;14279.785803212857;1910.808919108092;1967.3409407848387;1985.9772217308098;1990.99004504978;2021.2824447321136;66080.66959665171;68095.31904680989;68102.3189768106;69423;69650.30349696489;10631.84052239217;10793.67618971432;11122.054625356774;11162.60930867432;11275.492602832892;14741.778873316909;14745.92627036858;14856.405743770345;14862.331195096247;14890.255487225595;8171.9182808172345;8308.210719981593;8374.330053595697;8390.538520381315;8472.110428405053;8244.8351032979;8245.752627421187;8312.25189732927;8343.791405214919;8367.079621241659;6673.399394054559;6798;6824.761133360308;6846;6903.309669033057;1819.199552197029;1850.990745046266;1959.4820655457954;1960.7647082350209;1972.753405824272;953.8044700836311;975.7024107647094;1030.2427715629008;1036.4817591204398;1102.4542851288504;17676.292948282182;18181.45455636333;18197.636047278982;19037.333693320666;19103.808961910203;1040.360178490223;1054.435876805905;1060.3054998975683;1115.70991542198;1115.9944200278946;10871.782564348827;10970;11138.387388693538;11171.44142792857;11181.44092795357;458481;460581;471044;471497;484038;81847.5907620458;86727.56636216905;87107.56446217855;87183;87681.56159219163;1068.4283908109123;1111.7498562823462;1119.216548416112;1124.4939777100174;1126.6000569797604;16159.75760363572;16300.67398652044;16330.183490825173;16542.42101526441;16565.834341656428;36173.457398138526;36987.8150609256;38401;39129;39685.404718929814;54028;54464.183037255265;54487.18269226044;54523.45476545184;54596.72701636466;8655.91344086551;8701.129887011248;8723.258523025614;8734.91265087341;8778.517181555077;9021;10644.467776611293;11968.341741204318;13248.470061197444;13475.460981560627;9888.752781180528;10799.730006749895;10867.347959122479;11233.55065797359;11537.962362102598;10946.45267736594;11103.833442498208;11128.165387596124;11170.385628790495;11299.830502542303;10530.736731581772;10814.080803131506;11811.645650630495;11968.700782480508;12326.383680816103;8545.914540854512;8607.569621519024;8692.130786921258;8749.956250218707;8776.561171941505;11625.47685354178;11972.940135299268;12037.879621203676;12088.335141566946;12264.264144151022 21:53:45 INFO - PROCESS | 3409 | |3;mootools.html;1417.461364681421;1529.9923500382497;1542.1826431991042;1803.6482885837268;1957.9804201957977;7508.474406791527;7646.579438130901;7648.808779780501;7651.196624354446;7669;7941.08677502086;8125.471844330114;8133.552654603995;8140.308073813718;8146.3890208234325;2008.2167954497756;2056.7737548869613;2279.088364654135;2340.660604212388;2365.7634236576378;2291.163725240292;2296.1619009061656;2300.976990230093;2303.9308820735323;2304.9884750576307;2250.6173950428465;2278.327893271489;2296.575133600281;2303.8502497337618;2317.4553979814814;2302.2057390200353;2327.94180145496;2341.9648705269433;2347.0377145370485;2347.1315613223046;2315.097112126272;2351.094828491026;2375.180562705864;2378.096323397115;2380.202632118225;8130.430869839113;8215.917840821576;8224;8225.629846656855;8229.83540329196;4909.459959404463;5012.27322038306;5055.595552355802;5057.924131138036;5060;3157.747380209578;3159.3681263747344;3210.133264018725;3231.0952933178514;3250.951235731466;1086.3916206924148;2013.677811550145;2064.3910046536307;2069;2107.2413930984835;10876.238663293572;10932.890671093346;10971.396573188471;10982.890171098266;11011.669649910515;4103.815328310174;4287.935680964788;4295.763732994716;4339.848105316362;4348.869533913988;9060.093990600888;9100.044495328028;9106.134917182857;9120.543972801333;9128.08719128095;4846.903061938741;4864.878378040577;4867.7322747249245;4893.755312234445;4905.3623029006;3893.201893611803;4331.6318112960125;4357.237483440449;4415.448068991376;4416.227160247008;3641.672249497505;3692.7599706019023;3720.330340538729;3747.4191500317493;3775.244951009809;1046.3460337289193;1049.9737506562396;1051.7896420715888;1068.647346375694;1082.7617924056694;1453.8546145385376;1469;1470.0224350806807;1494.7757836324638;1498.7901693762883;8005.639746211435;8006.679732810622;8060.153683863227;8063.717769878143;8076.071251806;504.73249177935753;513.5095983335905;514.63975217348;516.8656149401182;526.4472304080776;6244.531660125509;6288.339724328971;6307.274663413675;6423.4861211103;6428.357164283628;9683.176929960891;10018.148457381205;10051.59793608262;10200.795984080276;10214.182865370902;9749;9856.66934963785;9944.950275248577;9981.051800078982;10040.046195611405;7804.921950780419;7811.140774514799;7887.723929662549;7997.120316765151;8007.759767206993;7714.807129821799;7718.073831140299;7759.68961241544;7790.14308426084;7839.216078392115;8596.226339629464;8914.33142514327;9090.409123406956;9187.586558604746;9201.815963680823;8911.643534258557;9163.175314221751;9170.174684278447;9220.815583688423;9353.39202951806;6107.511399088151;6262.499000079892;6626.635535045619;6862.073620061427;6921.1002569665625;7830.021247344082;7830.725924592612;7831.412644051605;7882.763517094496;7898.538770327508;7080.575165490087;7226.963865180641;7233;7292.270772922665;7349.77950661481;7182.174049984319;7206.171290301473;7211.819704507429;7220.097487814023;7285.235050319852;7182.066331376887;7240.456965727697;7251.601161936144;7256.129264488295;7376.373008294355;6557.508186886098;6610.438112760469;6612.933870661232;6626.966865165643;6640.236372817188;6771.729130834909;6899.137607799025;6916.619585922823;6918.515703900679;7142.964285178541 21:53:45 INFO - PROCESS | 3409 | |4;prototype.html;342.7523813319516;347.1252443841519;351.07841914973193;352.8253514510316;357.24264559134656;6012.458878700916;6039.939600603992;6067.423594758502;6077.665728384937;6093.75624975001;5980.671063091529;5980.760769569223;5989.580729348947;5993.610415323001;6029.366916473762;4430.5126436092005;4503.0318481526465;4566.589006989387;4614.007988282527;4632.606228470584;4591.885202869921;4593.977030114861;4616.238320677085;4618.307253911907;4632.189366860803;4578.542145785428;4580.7938642761155;4582.060677561092;4587.632989360844;4617.584417402433;4424.690271680967;4512.3682684424375;4575.977120114411;4578.679492435531;4631.096936097462;4084.6936479764136;4085.59144085592;4090.611391917793;4097.91804163918;4098.221337945811;5692.0608099663505;5696.601237913348;5698.51562617178;5705.429457054262;5713.914291285634;5405.351357837046;5411.296531450926;5411.457734545675;5428.348598168205;5436.320459942507;6351.174347334863;6362.618242905441;6364.649944253064;6366.649834259114;6367.681615919232;4268.423762792046;4378.605925466692;4436;4437.245668236407;4532.524084971096;6553;6604.306547812506;6611.867762644768;6613.636250006248;6624.304448032935;4534.79593418297;4535.63714902807;4539.546045395434;4543.4775000875325;4551.6813823032735;4594.035252596992;4606.516315786861;4609.239475486507;4613.561711637389;4624.421947256593;5311.787528498817;5325.786968521294;5328.307320048369;5333.333333333333;5333.493318134771;6304.590201636879;6353.459955903708;6387.297397286295;6409.67951602418;6429.54993150475;1596.4811436283255;1616.3373017062947;1629.2505447494286;1630.274527835102;1637.148682684997;1033.5245786937942;1056.1234175634206;1135.1543100390097;1145.5131569083105;1146.79357715612;6075.726592303357;6143.170671959318;6146.170267013986;6148.415900489446;6155.292141403706;6577.112089867806;6586.473082153416;6646.700898459581;6650.800475985729;6657.567258128303;6134.693265336805;6135.417135372132;6138.171346868205;6143.477804386677;6147.815565533041;3519.102628829632;3552.662497062775;3553.697935675445;3554.0581745837376;3559.056849934769;6614.404703576702;6747;6762.154730658668;6789.728410863609;6790.42281406086;6689.431398331099;6695.363940425652;6714.966425167843;6728.495362847708;6729.663516824139;6737.191537015491;6746.123004009545;6758.76344327956;6762.256151823295;6768.560043597249;6549.279579246374;6561.311062338576;6565.179352580927;6566.080748695091;6567.211934567882;6287.402696743802;6427.903581446376;6428.55000149985;6450.580712253689;6461.903071454026;6744.359285867835;6760.966195168992;6763.5941843489545;6777.966110169417;6784.084148640068;4697.694649847749;4702.27114797207;4704.082703872712;4706.082313948884;4706.835260765857;6549.836254093686;6562;6563.0811686364905;6565.441937435371;6575.178102737158;6246.500279977682;6363.872722545616;6376.202974628171;6381.425671689571;6393;6357.205349331333;6378.649174295459;6384.361563843579;6385.425311721968;6391.424771770563;6293.339199383999;6300.054991751274;6304.18045654062;6306.400891915261;6307.590006649553;6384.489240860627;6412.038194270896;6430.453411459891;6439.774607888701;6441.645709486023;6043.456088952015;6114.144019837137;6273.843153921189;6291.087792270004;6378.840528986812 21:53:45 INFO - PROCESS | 3409 | |5;yui.html;825.2119226139038;915.0346384564286;931.5295775633305;931.6413180925342;961.7162936933604;13934.163950162985;14058.578242652737;14085.295735213223;14416.927915360422;14547.345369458373;13018.674533136676;13843.653908652288;14172.716545669105;14173.858261417383;14188.21964791936;771.8610650082983;942.853857652065;944.4569372610742;961.1109723505764;971.0968799016912;958.4584709639032;963.02734238419;963.2967933408615;967.0474582536197;968.70454511374;1001.7846163074937;1002.3234316836143;1002.8144793213243;1003.1222680154865;1005.1456262177128;803.9196080391972;976.8241716491065;990.1089019882164;991.008991008991;996.0388225362524;724.5181954000583;730.0764532865929;731.4294850016995;731.5720303622387;733.3106879533221;14226.359813808403;14290.499162646494;14366.928165359106;14377.496787612383;14384.928075359661;13124.409401576951;13255.023492952076;13399.53101641438;13477.19136851792;13603.31983400826;10891.67324980244;10940.945295273472;10984.340939543654;11069.299310854916;11174.553017879274;3928.7249892507534;3969.4641223435046;3972.781497017663;3973.543042550115;3975.8210880510155;51547.48452515502;51651.483485165045;51663.48336516662;51687.22469162966;51764.74117629388;10384.896151038543;11004.284721493077;11482.196246262682;11632.127590430751;11748.58879939198;19637.80362196388;19753.308634197732;19779.802201978084;19794;19823.207071717257;8147.063087744867;8221.218984196492;8301.875471867927;8332.791680207922;8375.832483350421;4584.564466375689;4621.260598304255;4765.523447655207;4855.830045948375;4947.505249475023;3275.164832967578;3315.2209230830736;3317.8175200364212;3323.2522682396266;3328.86684532616;580.8954388210078;585.464300165344;609.1360437062602;613.8404014956144;615.7352338494491;558.6201383059478;567.3758865248194;620.8168590265882;702.6486756621689;706.9590350455269;8976.640934362684;9029.729108126767;9067.09329067088;9229.676961306457;9235.676751313806;649.9935000649933;673.6025744810586;715.1239731329081;737.6053811210976;764.900562926816;4232.894177645522;4309.6767742418815;4310.137972405469;4361.193179261847;4421.624161946271;61316.69341653263;62063.6896815513;62135.6893215531;62388.688056559426;62690;56460.71769641126;56645.43354566484;57478.71260643753;58320.4167958315;58609.4139058604;50499;50520.74739626352;50767.49232507627;50820.99999999926;51122.233166502534;9151.17639412456;9233.538323083952;9233.769155771159;9290.535473226448;9382.718518444457;37352.252954941294;37353.43969840509;37374;38808.6119138805;39419.605803941595;45858.312125318815;48989.51010489992;49265.32325776647;49760.502394975585;50108.24837627366;12063;12097.032237421161;12288.877111228774;12457.626271211879;12589.118761686594;12958.352082395653;13081.215127092404;13402.128861623964;13519.256440895846;13619.86380136186;12496.625101246977;12522.624321270376;12639.368031598568;13152.934235328763;13505;12872.16330938486;12961.935190324366;12979;13128;13181.934090329487;11785.528578856749;11820.527178913091;11897.107716921439;12086.51653933868;12802.463704355538;10684.679459616224;10884.782304354027;10971.670849874517;11053;11343.659690209306;10884.455777211266;11131.944340278247;11133.332000080021;11147.888521114684;11193.384363859741 21:53:45 INFO - PROCESS | 3409 | __end_tp_report 21:53:45 INFO - PROCESS | 3409 | __start_cc_report 21:53:45 INFO - PROCESS | 3409 | _x_x_mozilla_cycle_collect,822 21:53:45 INFO - PROCESS | 3409 | __end_cc_report 21:53:45 INFO - PROCESS | 3409 | __startTimestamp1458276825577__endTimestamp 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | ------- Summary: start ------- 21:53:45 INFO - PROCESS | 3409 | Number of tests: 6 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | [#0] dojo.html Cycles:165 Average:5258.20 Median:5455.92 stddev:558.49 (10.2%) stddev-sans-first:536.63 21:53:45 INFO - PROCESS | 3409 | Values: 3211.8 3273.7 3303.8 3311.6 3337.3 5285.5 5304.5 5322.1 5323.5 5383.3 5314.5 5318.5 5345.6 5355.5 5362.3 4698.1 4886.9 4898.8 4938.2 4968.5 4734.3 4780.5 4809.8 4863.5 4864.4 4816.3 4864.2 4877.8 4894.4 4937.4 4831.5 4846.7 4858.7 4859.3 4862.9 4734.1 4781.3 4793.1 4853.7 4888.1 5157.7 5158.8 5163.5 5168.3 5193.1 5650.9 5655.5 5660.7 5664.5 5697.3 5517.4 5621.6 5654.0 5691.6 5741.2 5238.3 5240.9 5241.8 5242.4 5244.8 5617.0 5722.3 5724.2 5724.8 5730.5 5609.4 5678.8 5683.5 5711.9 5715.2 5428.1 5429.0 5448.4 5451.4 5486.4 5443.3 5452.6 5460.7 5473.8 5517.7 5647.1 5648.7 5654.4 5654.8 5670.3 4340.2 4348.5 4348.7 4354.8 4373.8 3796.9 3899.8 3942.3 3944.4 3976.0 5193.2 5214.5 5226.2 5260.4 5318.6 5657.7 5668.1 5670.9 5675.4 5682.5 5100.0 5246.9 5339.0 5392.1 5420.1 4845.2 4849.9 4854.5 4854.7 4889.1 5729.3 5737.5 5738.1 5738.3 5752.7 5585.6 5600.3 5695.1 5789.2 5795.8 5788.0 5833.4 5834.6 5836.8 5841.5 5600.9 5629.7 5631.1 5640.9 5649.2 5511.6 5644.9 5708.2 5718.8 5747.9 5528.4 5530.4 5547.0 5561.8 5566.8 5455.9 5550.1 5562.2 5563.7 5571.2 5493.2 5573.8 5584.6 5595.0 5613.6 5602.0 5636.4 5638.2 5643.9 5655.2 5296.7 5467.3 5522.7 5543.6 5550.9 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | [#1] ext.html Cycles:180 Average:47035.85 Median:35088.65 stddev:74346.21 (211.9%) stddev-sans-first:74472.74 21:53:45 INFO - PROCESS | 3409 | Values: 522.9 550.2 555.9 564.1 596.6 31733.2 32445.2 41128.2 41769.6 41830.8 44961.8 45300.8 45366.1 45564.0 45620.0 7977.8 8903.0 9145.0 9234.9 9235.8 8013.4 11016.6 11314.4 11315.5 11323.4 10908.3 11006.6 11012.6 11023.7 11026.7 10829.9 10910.1 10949.4 10950.7 10961.3 10589.2 10771.1 10771.4 10778.2 10790.1 40647.6 44107.3 44167.3 44188.6 44221.3 3581.6 4057.9 4285.8 4356.7 4479.2 34596.1 34790.7 34901.0 35039.6 35137.6 4227.0 4245.9 4249.8 4255.4 4308.0 249762.0 251045.0 251195.7 251416.0 252688.0 63549.4 63675.4 63810.0 64433.0 64494.0 76767.6 77738.6 78126.0 78166.0 78170.6 16593.8 16608.0 16673.4 16727.3 16812.2 11451.7 12445.6 12728.6 12858.9 12861.1 21964.7 22309.6 22363.2 22467.7 22548.7 8445.9 8508.0 8538.7 8594.7 8704.4 1064.2 1112.5 1118.8 1121.0 1234.0 31323.5 31517.8 31544.0 31825.4 32178.4 1145.8 1193.3 1216.2 1240.6 1270.8 16240.3 16472.6 16515.6 16590.0 17057.0 369635.0 372272.0 372401.0 373430.0 374237.1 61945.4 62461.7 62849.4 62935.7 62940.0 1361.0 1402.3 1485.0 1530.2 1569.9 28093.3 28241.4 28272.2 28801.0 29199.4 45165.3 45227.0 45545.5 45560.0 45571.5 197846.0 198809.0 199153.0 199345.0 199574.0 30815.8 35405.3 35563.5 35618.1 36437.8 43211.4 43987.0 44068.1 44678.3 44997.8 36471.6 36654.5 37031.6 37232.8 38081.6 38562.4 38659.0 39056.8 39518.4 39955.0 38918.8 39128.8 44467.3 45541.8 45553.8 31864.4 33429.5 33434.8 33571.5 33713.0 26167.9 26416.5 26544.2 26582.3 26914.5 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | [#2] jquery.html Cycles:180 Average:27739.03 Median:12300.14 stddev:77062.74 (626.5%) stddev-sans-first:77251.52 21:53:45 INFO - PROCESS | 3409 | Values: 370.8 389.9 392.2 392.9 400.3 17711.8 19156.7 19578.7 19667.6 19699.6 17877.2 17903.0 18501.6 18535.1 18769.5 5632.0 5781.3 5783.6 5796.1 5837.2 4292.9 5922.8 6370.0 6380.4 6393.1 6290.8 6321.8 6335.8 6344.5 6350.0 6233.6 6334.7 6341.8 6379.4 6395.6 3898.1 5308.6 5473.7 5483.5 5485.3 21762.7 21963.2 22140.4 22258.3 22267.4 2332.8 2390.6 2420.0 2449.4 2554.9 13734.7 13885.2 13987.0 14066.3 14279.8 1910.8 1967.3 1986.0 1991.0 2021.3 66080.7 68095.3 68102.3 69423.0 69650.3 10631.8 10793.7 11122.1 11162.6 11275.5 14741.8 14745.9 14856.4 14862.3 14890.3 8171.9 8308.2 8374.3 8390.5 8472.1 8244.8 8245.8 8312.3 8343.8 8367.1 6673.4 6798.0 6824.8 6846.0 6903.3 1819.2 1851.0 1959.5 1960.8 1972.8 953.8 975.7 1030.2 1036.5 1102.5 17676.3 18181.5 18197.6 19037.3 19103.8 1040.4 1054.4 1060.3 1115.7 1116.0 10871.8 10970.0 11138.4 11171.4 11181.4 458481.0 460581.0 471044.0 471497.0 484038.0 81847.6 86727.6 87107.6 87183.0 87681.6 1068.4 1111.7 1119.2 1124.5 1126.6 16159.8 16300.7 16330.2 16542.4 16565.8 36173.5 36987.8 38401.0 39129.0 39685.4 54028.0 54464.2 54487.2 54523.5 54596.7 8655.9 8701.1 8723.3 8734.9 8778.5 9021.0 10644.5 11968.3 13248.5 13475.5 9888.8 10799.7 10867.3 11233.6 11538.0 10946.5 11103.8 11128.2 11170.4 11299.8 10530.7 10814.1 11811.6 11968.7 12326.4 8545.9 8607.6 8692.1 8750.0 8776.6 11625.5 11972.9 12037.9 12088.3 12264.3 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | [#3] mootools.html Cycles:180 Average:5701.23 Median:6176.02 stddev:2967.60 (48.1%) stddev-sans-first:2958.46 21:53:45 INFO - PROCESS | 3409 | Values: 1417.5 1530.0 1542.2 1803.6 1958.0 7508.5 7646.6 7648.8 7651.2 7669.0 7941.1 8125.5 8133.6 8140.3 8146.4 2008.2 2056.8 2279.1 2340.7 2365.8 2291.2 2296.2 2301.0 2303.9 2305.0 2250.6 2278.3 2296.6 2303.9 2317.5 2302.2 2327.9 2342.0 2347.0 2347.1 2315.1 2351.1 2375.2 2378.1 2380.2 8130.4 8215.9 8224.0 8225.6 8229.8 4909.5 5012.3 5055.6 5057.9 5060.0 3157.7 3159.4 3210.1 3231.1 3251.0 1086.4 2013.7 2064.4 2069.0 2107.2 10876.2 10932.9 10971.4 10982.9 11011.7 4103.8 4287.9 4295.8 4339.8 4348.9 9060.1 9100.0 9106.1 9120.5 9128.1 4846.9 4864.9 4867.7 4893.8 4905.4 3893.2 4331.6 4357.2 4415.4 4416.2 3641.7 3692.8 3720.3 3747.4 3775.2 1046.3 1050.0 1051.8 1068.6 1082.8 1453.9 1469.0 1470.0 1494.8 1498.8 8005.6 8006.7 8060.2 8063.7 8076.1 504.7 513.5 514.6 516.9 526.4 6244.5 6288.3 6307.3 6423.5 6428.4 9683.2 10018.1 10051.6 10200.8 10214.2 9749.0 9856.7 9945.0 9981.1 10040.0 7804.9 7811.1 7887.7 7997.1 8007.8 7714.8 7718.1 7759.7 7790.1 7839.2 8596.2 8914.3 9090.4 9187.6 9201.8 8911.6 9163.2 9170.2 9220.8 9353.4 6107.5 6262.5 6626.6 6862.1 6921.1 7830.0 7830.7 7831.4 7882.8 7898.5 7080.6 7227.0 7233.0 7292.3 7349.8 7182.2 7206.2 7211.8 7220.1 7285.2 7182.1 7240.5 7251.6 7256.1 7376.4 6557.5 6610.4 6612.9 6627.0 6640.2 6771.7 6899.1 6916.6 6918.5 7143.0 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | [#4] prototype.html Cycles:180 Average:5338.77 Median:6085.71 stddev:1594.28 (26.2%) stddev-sans-first:1554.03 21:53:45 INFO - PROCESS | 3409 | Values: 342.8 347.1 351.1 352.8 357.2 6012.5 6039.9 6067.4 6077.7 6093.8 5980.7 5980.8 5989.6 5993.6 6029.4 4430.5 4503.0 4566.6 4614.0 4632.6 4591.9 4594.0 4616.2 4618.3 4632.2 4578.5 4580.8 4582.1 4587.6 4617.6 4424.7 4512.4 4576.0 4578.7 4631.1 4084.7 4085.6 4090.6 4097.9 4098.2 5692.1 5696.6 5698.5 5705.4 5713.9 5405.4 5411.3 5411.5 5428.3 5436.3 6351.2 6362.6 6364.6 6366.6 6367.7 4268.4 4378.6 4436.0 4437.2 4532.5 6553.0 6604.3 6611.9 6613.6 6624.3 4534.8 4535.6 4539.5 4543.5 4551.7 4594.0 4606.5 4609.2 4613.6 4624.4 5311.8 5325.8 5328.3 5333.3 5333.5 6304.6 6353.5 6387.3 6409.7 6429.5 1596.5 1616.3 1629.3 1630.3 1637.1 1033.5 1056.1 1135.2 1145.5 1146.8 6075.7 6143.2 6146.2 6148.4 6155.3 6577.1 6586.5 6646.7 6650.8 6657.6 6134.7 6135.4 6138.2 6143.5 6147.8 3519.1 3552.7 3553.7 3554.1 3559.1 6614.4 6747.0 6762.2 6789.7 6790.4 6689.4 6695.4 6715.0 6728.5 6729.7 6737.2 6746.1 6758.8 6762.3 6768.6 6549.3 6561.3 6565.2 6566.1 6567.2 6287.4 6427.9 6428.6 6450.6 6461.9 6744.4 6761.0 6763.6 6778.0 6784.1 4697.7 4702.3 4704.1 4706.1 4706.8 6549.8 6562.0 6563.1 6565.4 6575.2 6246.5 6363.9 6376.2 6381.4 6393.0 6357.2 6378.6 6384.4 6385.4 6391.4 6293.3 6300.1 6304.2 6306.4 6307.6 6384.5 6412.0 6430.5 6439.8 6441.6 6043.5 6114.1 6273.8 6291.1 6378.8 21:53:45 INFO - PROCESS | 3409 | 21:53:45 INFO - PROCESS | 3409 | [#5] yui.html Cycles:180 Average:15077.40 Median:4271.29 stddev:17403.01 (407.4%) stddev-sans-first:17418.91 21:53:45 INFO - PROCESS | 3409 | Values: 825.2 915.0 931.5 931.6 961.7 13934.2 14058.6 14085.3 14416.9 14547.3 13018.7 13843.7 14172.7 14173.9 14188.2 771.9 942.9 944.5 961.1 971.1 958.5 963.0 963.3 967.0 968.7 1001.8 1002.3 1002.8 1003.1 1005.1 803.9 976.8 990.1 991.0 996.0 724.5 730.1 731.4 731.6 733.3 14226.4 14290.5 14366.9 14377.5 14384.9 13124.4 13255.0 13399.5 13477.2 13603.3 10891.7 10940.9 10984.3 11069.3 11174.6 3928.7 3969.5 3972.8 3973.5 3975.8 51547.5 51651.5 51663.5 51687.2 51764.7 10384.9 11004.3 11482.2 11632.1 11748.6 19637.8 19753.3 19779.8 19794.0 19823.2 8147.1 8221.2 8301.9 8332.8 8375.8 4584.6 4621.3 4765.5 4855.8 4947.5 3275.2 3315.2 3317.8 3323.3 3328.9 580.9 585.5 609.1 613.8 615.7 558.6 567.4 620.8 702.6 707.0 8976.6 9029.7 9067.1 9229.7 9235.7 650.0 673.6 715.1 737.6 764.9 4232.9 4309.7 4310.1 4361.2 4421.6 61316.7 62063.7 62135.7 62388.7 62690.0 56460.7 56645.4 57478.7 58320.4 58609.4 50499.0 50520.7 50767.5 50821.0 51122.2 9151.2 9233.5 9233.8 9290.5 9382.7 37352.3 37353.4 37374.0 38808.6 39419.6 45858.3 48989.5 49265.3 49760.5 50108.2 12063.0 12097.0 12288.9 12457.6 12589.1 12958.4 13081.2 13402.1 13519.3 13619.9 12496.6 12522.6 12639.4 13152.9 13505.0 12872.2 12961.9 12979.0 13128.0 13181.9 11785.5 11820.5 11897.1 12086.5 12802.5 10684.7 10884.8 10971.7 11053.0 11343.7 10884.5 11131.9 11133.3 11147.9 11193.4 21:53:45 INFO - PROCESS | 3409 | -------- Summary: end -------- 21:53:45 INFO - PROCESS | 3409 | 21:53:46 INFO - TEST-INFO | 3409: exit 0 21:53:46 INFO - TEST-OK | dromaeo_css | took 1111943ms 21:53:46 INFO - TEST-START | kraken 21:53:46 INFO - operating with platform_type : linux_ 21:53:46 INFO - Initialising browser for kraken test... 21:53:46 INFO - TEST-INFO | started process 3595 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvhLuPj/profile http://localhost:49658/getInfo.html) 21:53:50 INFO - PROCESS | 3595 | __metrics Screen width/height:1600/1200 21:53:50 INFO - PROCESS | 3595 | colorDepth:24 21:53:50 INFO - PROCESS | 3595 | Browser inner width/height: 1024/697 21:53:50 INFO - PROCESS | 3595 | __metrics 21:53:51 INFO - PROCESS | 3595 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:53:51 INFO - PROCESS | 3595 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 21:53:52 INFO - TEST-INFO | 3595: exit 0 21:53:52 INFO - Browser initialized. 21:53:52 INFO - Running cycle 1/1 for kraken test... 21:53:52 INFO - TEST-INFO | started process 3688 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvhLuPj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:03 INFO - PROCESS | 3688 | RSS: Main: 144343040 21:54:03 INFO - PROCESS | 3688 | 21:54:06 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49658/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:06 INFO - PROCESS | 3688 | RSS: Main: 180883456 21:54:06 INFO - PROCESS | 3688 | 21:54:09 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49658/tests/kraken/driver.html?testName=audio-dft) 21:54:10 INFO - PROCESS | 3688 | RSS: Main: 178323456 21:54:10 INFO - PROCESS | 3688 | 21:54:12 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49658/tests/kraken/driver.html?testName=audio-fft) 21:54:13 INFO - PROCESS | 3688 | RSS: Main: 175443968 21:54:13 INFO - PROCESS | 3688 | 21:54:15 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49658/tests/kraken/driver.html?testName=audio-oscillator) 21:54:16 INFO - PROCESS | 3688 | RSS: Main: 177786880 21:54:16 INFO - PROCESS | 3688 | 21:54:18 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:18 INFO - PROCESS | 3688 | RSS: Main: 173772800 21:54:18 INFO - PROCESS | 3688 | 21:54:21 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49658/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:22 INFO - PROCESS | 3688 | RSS: Main: 173645824 21:54:22 INFO - PROCESS | 3688 | 21:54:25 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49658/tests/kraken/driver.html?testName=imaging-desaturate) 21:54:26 INFO - PROCESS | 3688 | RSS: Main: 174710784 21:54:26 INFO - PROCESS | 3688 | 21:54:29 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49658/tests/kraken/driver.html?testName=json-parse-financial) 21:54:29 INFO - PROCESS | 3688 | RSS: Main: 176087040 21:54:29 INFO - PROCESS | 3688 | 21:54:31 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:54:31 INFO - PROCESS | 3688 | RSS: Main: 179204096 21:54:31 INFO - PROCESS | 3688 | 21:54:33 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:54:34 INFO - PROCESS | 3688 | RSS: Main: 176279552 21:54:34 INFO - PROCESS | 3688 | 21:54:36 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:36 INFO - PROCESS | 3688 | RSS: Main: 182149120 21:54:36 INFO - PROCESS | 3688 | 21:54:39 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:39 INFO - PROCESS | 3688 | RSS: Main: 187326464 21:54:39 INFO - PROCESS | 3688 | 21:54:42 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:42 INFO - PROCESS | 3688 | RSS: Main: 187990016 21:54:42 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49658/tests/kraken/driver.html?testName=ai-astar) 21:54:44 INFO - PROCESS | 3688 | RSS: Main: 249020416 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | __start_tp_report 21:54:44 INFO - PROCESS | 3688 | _x_x_mozilla_page_load 21:54:44 INFO - PROCESS | 3688 | _x_x_mozilla_page_load_details 21:54:44 INFO - PROCESS | 3688 | |i|pagename|runs| 21:54:44 INFO - PROCESS | 3688 | |0;ai-astar;110;111;106;111;111;112;101;111;110;109 21:54:44 INFO - PROCESS | 3688 | |1;audio-beat-detection;150;126;151;176;126;149;151;131;186;126 21:54:44 INFO - PROCESS | 3688 | |2;audio-dft;161;162;161;162;160;161;160;162;160;159 21:54:44 INFO - PROCESS | 3688 | |3;audio-fft;75;75;75;162;75;76;75;75;155;74 21:54:44 INFO - PROCESS | 3688 | |4;audio-oscillator;93;93;139;93;93;93;146;93;93;141 21:54:44 INFO - PROCESS | 3688 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;116;117;117 21:54:44 INFO - PROCESS | 3688 | |6;imaging-darkroom;146;146;146;145;146;145;146;145;146;146 21:54:44 INFO - PROCESS | 3688 | |7;imaging-desaturate;96;96;96;95;96;96;95;96;96;95 21:54:44 INFO - PROCESS | 3688 | |8;json-parse-financial;54;58;58;56;57;56;57;65;54;56 21:54:44 INFO - PROCESS | 3688 | |9;json-stringify-tinderbox;64;65;64;68;65;66;65;64;65;65 21:54:44 INFO - PROCESS | 3688 | |10;stanford-crypto-aes;77;77;78;86;79;77;85;77;79;78 21:54:44 INFO - PROCESS | 3688 | |11;stanford-crypto-ccm;127;111;127;110;113;111;126;122;111;116 21:54:44 INFO - PROCESS | 3688 | |12;stanford-crypto-pbkdf2;148;137;148;132;140;132;142;140;140;146 21:54:44 INFO - PROCESS | 3688 | |13;stanford-crypto-sha256-iterative;65;65;68;64;64;65;66;67;66;66 21:54:44 INFO - PROCESS | 3688 | __end_tp_report 21:54:44 INFO - PROCESS | 3688 | __start_cc_report 21:54:44 INFO - PROCESS | 3688 | _x_x_mozilla_cycle_collect,1023 21:54:44 INFO - PROCESS | 3688 | __end_cc_report 21:54:44 INFO - PROCESS | 3688 | __startTimestamp1458276884698__endTimestamp 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | ------- Summary: start ------- 21:54:44 INFO - PROCESS | 3688 | Number of tests: 14 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.33 (3.0%) stddev-sans-first:3.52 21:54:44 INFO - PROCESS | 3688 | Values: 110.0 111.0 106.0 111.0 111.0 112.0 101.0 111.0 110.0 109.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:150.50 stddev:21.04 (14.0%) stddev-sans-first:22.30 21:54:44 INFO - PROCESS | 3688 | Values: 150.0 126.0 151.0 176.0 126.0 149.0 151.0 131.0 186.0 126.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 21:54:44 INFO - PROCESS | 3688 | Values: 161.0 162.0 161.0 162.0 160.0 161.0 160.0 162.0 160.0 159.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:35.25 (47.0%) stddev-sans-first:36.86 21:54:44 INFO - PROCESS | 3688 | Values: 75.0 75.0 75.0 162.0 75.0 76.0 75.0 75.0 155.0 74.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.73 (25.5%) stddev-sans-first:24.57 21:54:44 INFO - PROCESS | 3688 | Values: 93.0 93.0 139.0 93.0 93.0 93.0 146.0 93.0 93.0 141.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:54:44 INFO - PROCESS | 3688 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:54:44 INFO - PROCESS | 3688 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:54:44 INFO - PROCESS | 3688 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:3.11 (5.5%) stddev-sans-first:3.09 21:54:44 INFO - PROCESS | 3688 | Values: 54.0 58.0 58.0 56.0 57.0 56.0 57.0 65.0 54.0 56.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 21:54:44 INFO - PROCESS | 3688 | Values: 64.0 65.0 64.0 68.0 65.0 66.0 65.0 64.0 65.0 65.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:3.37 (4.3%) stddev-sans-first:3.47 21:54:44 INFO - PROCESS | 3688 | Values: 77.0 77.0 78.0 86.0 79.0 77.0 85.0 77.0 79.0 78.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:119.00 stddev:7.29 (6.1%) stddev-sans-first:6.86 21:54:44 INFO - PROCESS | 3688 | Values: 127.0 111.0 127.0 110.0 113.0 111.0 126.0 122.0 111.0 116.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:141.00 stddev:5.80 (4.1%) stddev-sans-first:5.48 21:54:44 INFO - PROCESS | 3688 | Values: 148.0 137.0 148.0 132.0 140.0 132.0 142.0 140.0 140.0 146.0 21:54:44 INFO - PROCESS | 3688 | 21:54:44 INFO - PROCESS | 3688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 21:54:44 INFO - PROCESS | 3688 | Values: 65.0 65.0 68.0 64.0 64.0 65.0 66.0 67.0 66.0 66.0 21:54:44 INFO - PROCESS | 3688 | -------- Summary: end -------- 21:54:44 INFO - PROCESS | 3688 | 21:54:45 INFO - TEST-INFO | 3688: exit 0 21:54:45 INFO - TEST-OK | kraken | took 59297ms 21:54:45 INFO - SUITE-END | took 1171s 21:54:45 INFO - Completed test suite (00:19:31) 21:54:45 INFO - javascript benchmark 21:54:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3211.7751757376986, 3273.6889995450424, 3303.834808259586, 3311.5694959655243, 3337.265801523665, 5285.471452854717, 5304.469553044699, 5322.068637988346, 5323.520883120518, 5383.273258110159, 5314.548263397606, 5318.494742999418, 5345.572354211664, 5355.464453554642, 5362.3029006229135, 4698.083873644624, 4886.926696099561, 4898.779554920028, 4938.2098864181735, 4968.453470118284, 4734.266188740734, 4780.450248221447, 4809.807607695706, 4863.489333619972, 4864.367632207808, 4816.277558366256, 4864.173090574611, 4877.756112194394, 4894.437139728923, 4937.407511098673, 4831.4685384607665, 4846.733429661367, 4858.708477491362, 4859.295402166684, 4862.854114376574, 4734.053189362141, 4781.306710526989, 4793.137235297645, 4853.733044682541, 4888.120138375091, 5157.742112894378, 5158.845234642929, 5163.535281824654, 5168.2764412982215, 5193.1171700810955, 5650.943490565124, 5655.547556195535, 5660.688662123582, 5664.461876121762, 5697.287839020122, 5517.44825517449, 5621.550275977953, 5654.0, 5691.573132015115, 5741.167530708066, 5238.292830467914, 5240.895182096375, 5241.764120614582, 5242.449542797989, 5244.816431424882, 5616.971915140398, 5722.341930677942, 5724.227229323988, 5724.799632012943, 5730.455606717355, 5609.439056094439, 5678.772849086073, 5683.460071293221, 5711.914321285184, 5715.228444159985, 5428.131498960148, 5429.0, 5448.400675925645, 5451.400345961941, 5486.423925487767, 5443.265159203457, 5452.6183167177915, 5460.6996615186545, 5473.8357849264585, 5517.724113794295, 5647.124695672177, 5648.6893220872425, 5654.37801841797, 5654.830355089354, 5670.262865827416, 4340.175366680321, 4348.5216626171095, 4348.673849461303, 4354.847580334673, 4373.759443230653, 3796.8671096512044, 3899.7855117968215, 3942.329803933338, 3944.36890097583, 3976.025873660914, 5193.246979188072, 5214.530692237641, 5226.242194881721, 5260.368755749258, 5318.627696061316, 5657.717114144276, 5668.064769313017, 5670.858228544237, 5675.404082571271, 5682.460166284196, 5100.0, 5246.947530524722, 5339.0389729849, 5392.137258038695, 5420.07858664028, 4845.248986407042, 4849.854504364875, 4854.490278520775, 4854.708717476963, 4889.071076495455, 5729.28383952006, 5737.540996720252, 5738.053221218535, 5738.282714660668, 5752.654840709571, 5585.5531557476115, 5600.299962504687, 5695.145728140812, 5789.218455508452, 5795.768169273182, 5787.971060144672, 5833.445822646841, 5834.591578589458, 5836.766529338779, 5841.532677385884, 5600.943990560042, 5629.746661400165, 5631.099024156116, 5640.915386269127, 5649.180868774087, 5511.559075273888, 5644.9435505644415, 5708.229389032427, 5718.771249149988, 5747.913781293368, 5528.364238112668, 5530.391656917655, 5546.973809845192, 5561.833145005657, 5566.805161819317, 5455.918161227505, 5550.111982082847, 5562.193481945176, 5563.670626710617, 5571.164325351229, 5493.176023596333, 5573.804916827891, 5584.581156413204, 5595.0208713475795, 5613.550915926634, 5602.0, 5636.408177141341, 5638.154276858504, 5643.858903527444, 5655.236543066633, 5296.708681022426, 5467.316585426822, 5522.66863988162, 5543.556515478833, 5550.916736248879], "unit": "score", "name": "dojo.html", "value": 5223.927507076637}, {"lowerIsBetter": false, "replicates": [522.9189475631279, 550.2241839007, 555.8721494056366, 564.0692856786303, 596.6181643747999, 31733.20666983324, 32445.188870278256, 41128.17743645129, 41769.58230417695, 41830.790846045806, 44961.77519112408, 45300.773496132555, 45366.092678146415, 45564.0, 45620.0, 7977.800554986143, 8903.020667726561, 9144.954275228614, 9234.907650923506, 9235.815283694323, 8013.358931285483, 11016.614418495354, 11314.434278286093, 11315.547378104866, 11323.43382830855, 10908.34549927003, 11006.614768483065, 11012.559497620086, 11023.724406889853, 11026.669199924016, 10829.891701082966, 10910.127189824794, 10949.397783121925, 10950.671479855617, 10961.287516311455, 10589.205809564237, 10771.138308935266, 10771.353718776898, 10778.245522813328, 10790.082842958358, 40647.59352406468, 44107.338389924174, 44167.33748993768, 44188.55811441877, 44221.336679949825, 3581.6239294874185, 4057.8637981365264, 4285.8499952501825, 4356.6950313477755, 4479.238529450001, 34596.13509662254, 34790.652093478995, 34901.0, 35039.64960350415, 35137.648623513945, 4226.978865105655, 4245.87262382129, 4249.787510624456, 4255.446791917062, 4308.0, 249762.0, 251045.0, 251195.74402128055, 251416.0, 252688.0, 63549.36450635527, 63675.36324636694, 63809.99999999907, 64433.0, 64494.0, 76767.61616191884, 77738.6113069431, 78126.0, 78166.0, 78170.60914695504, 16593.751093733605, 16608.00351978885, 16673.416430424877, 16727.330906763837, 16812.24344904482, 11451.656450306504, 12445.62663120108, 12728.554500592434, 12858.9357053216, 12861.099723019299, 21964.670529942065, 22309.553808924054, 22363.21728739519, 22467.662985055238, 22548.66177007346, 8445.873311900326, 8508.0, 8538.669918731699, 8594.742157735278, 8704.390692651581, 1064.1965316186383, 1112.4604566785104, 1118.7706520163347, 1121.0, 1233.9881297336099, 31323.53014704781, 31517.842410788257, 31544.0, 31825.363492730015, 32178.35643287168, 1145.8223975283845, 1193.3436609864539, 1216.1851559455185, 1240.621610408834, 1270.7712611729978, 16240.269187886573, 16472.588185295463, 16515.58711032234, 16590.0, 17056.976581405157, 369635.0, 372272.0, 372401.0, 373430.0, 374237.1288143542, 61945.38054619396, 62461.68769156216, 62849.371506284355, 62935.68532157401, 62940.0, 1360.9659758506116, 1402.3479082226813, 1484.9703005940037, 1530.211940850463, 1569.9372025118867, 28093.297667558476, 28241.43517129605, 28272.15183544497, 28801.0, 29199.416011680074, 45165.322520161564, 45227.0, 45545.54454455546, 45560.0, 45571.54428455673, 197846.0, 198809.0, 199153.0, 199345.0, 199574.0, 30815.845920770254, 35405.29189416249, 35563.466548001285, 35618.10954726049, 36437.817810910776, 43211.35182972321, 43987.0, 44068.11863762642, 44678.329825052, 44997.77501112605, 36471.63528364682, 36654.450183246736, 37031.62968370282, 37232.81383593065, 38081.61918380781, 38562.421563676005, 38659.0, 39056.804715976235, 39518.40722389109, 39955.0, 38918.80540597279, 39128.80435597918, 44467.33299000453, 45541.77229113833, 45553.77223113863, 31864.36271274515, 33429.49855752117, 33434.832825835714, 33571.49642755409, 33713.0, 26167.869160654074, 26416.471670566865, 26544.203673889813, 26582.335441614116, 26914.461710766067], "unit": "score", "name": "ext.html", "value": 20105.821335662622}, {"lowerIsBetter": false, "replicates": [370.82385866713315, 389.8830350894731, 392.23318412503556, 392.9410588411738, 400.2715058593361, 17711.82288177118, 19156.712649310255, 19578.70631940522, 19667.60664786707, 19699.60600787985, 17877.195526201318, 17903.0, 18501.629967400644, 18535.073246337695, 18769.530761730963, 5631.971840140794, 5781.335146458169, 5783.6240644358195, 5796.07262837946, 5837.24115864937, 4292.871213863589, 5922.763089476416, 6369.968150159243, 6380.361963803629, 6393.136926514908, 6290.811275661715, 6321.841953951142, 6335.778247761329, 6344.460720838734, 6349.968250158766, 6233.625982441068, 6334.714937827809, 6341.778037768679, 6379.393957574023, 6395.552311338208, 3898.142408670088, 5308.575313974873, 5473.67157970523, 5483.506484416422, 5485.314335708036, 21762.673559896615, 21963.23128690504, 22140.446488837748, 22258.332250032527, 22267.44331391712, 2332.8367014309006, 2390.581648211556, 2420.0, 2449.448874003335, 2554.885030173628, 13734.65663358424, 13885.166889986633, 13987.0, 14066.2966851657, 14279.785803212857, 1910.808919108092, 1967.3409407848387, 1985.9772217308098, 1990.99004504978, 2021.2824447321136, 66080.66959665171, 68095.31904680989, 68102.3189768106, 69423.0, 69650.30349696489, 10631.84052239217, 10793.67618971432, 11122.054625356774, 11162.60930867432, 11275.492602832892, 14741.778873316909, 14745.92627036858, 14856.405743770345, 14862.331195096247, 14890.255487225595, 8171.9182808172345, 8308.210719981593, 8374.330053595697, 8390.538520381315, 8472.110428405053, 8244.8351032979, 8245.752627421187, 8312.25189732927, 8343.791405214919, 8367.079621241659, 6673.399394054559, 6798.0, 6824.761133360308, 6846.0, 6903.309669033057, 1819.199552197029, 1850.990745046266, 1959.4820655457954, 1960.7647082350209, 1972.753405824272, 953.8044700836311, 975.7024107647094, 1030.2427715629008, 1036.4817591204398, 1102.4542851288504, 17676.292948282182, 18181.45455636333, 18197.636047278982, 19037.333693320666, 19103.808961910203, 1040.360178490223, 1054.435876805905, 1060.3054998975683, 1115.70991542198, 1115.9944200278946, 10871.782564348827, 10970.0, 11138.387388693538, 11171.44142792857, 11181.44092795357, 458481.0, 460581.0, 471044.0, 471497.0, 484038.0, 81847.5907620458, 86727.56636216905, 87107.56446217855, 87183.0, 87681.56159219163, 1068.4283908109123, 1111.7498562823462, 1119.216548416112, 1124.4939777100174, 1126.6000569797604, 16159.75760363572, 16300.67398652044, 16330.183490825173, 16542.42101526441, 16565.834341656428, 36173.457398138526, 36987.8150609256, 38401.0, 39129.0, 39685.404718929814, 54028.0, 54464.183037255265, 54487.18269226044, 54523.45476545184, 54596.72701636466, 8655.91344086551, 8701.129887011248, 8723.258523025614, 8734.91265087341, 8778.517181555077, 9021.0, 10644.467776611293, 11968.341741204318, 13248.470061197444, 13475.460981560627, 9888.752781180528, 10799.730006749895, 10867.347959122479, 11233.55065797359, 11537.962362102598, 10946.45267736594, 11103.833442498208, 11128.165387596124, 11170.385628790495, 11299.830502542303, 10530.736731581772, 10814.080803131506, 11811.645650630495, 11968.700782480508, 12326.383680816103, 8545.914540854512, 8607.569621519024, 8692.130786921258, 8749.956250218707, 8776.561171941505, 11625.47685354178, 11972.940135299268, 12037.879621203676, 12088.335141566946, 12264.264144151022], "unit": "score", "name": "jquery.html", "value": 9293.387376031915}, {"lowerIsBetter": false, "replicates": [1417.461364681421, 1529.9923500382497, 1542.1826431991042, 1803.6482885837268, 1957.9804201957977, 7508.474406791527, 7646.579438130901, 7648.808779780501, 7651.196624354446, 7669.0, 7941.08677502086, 8125.471844330114, 8133.552654603995, 8140.308073813718, 8146.3890208234325, 2008.2167954497756, 2056.7737548869613, 2279.088364654135, 2340.660604212388, 2365.7634236576378, 2291.163725240292, 2296.1619009061656, 2300.976990230093, 2303.9308820735323, 2304.9884750576307, 2250.6173950428465, 2278.327893271489, 2296.575133600281, 2303.8502497337618, 2317.4553979814814, 2302.2057390200353, 2327.94180145496, 2341.9648705269433, 2347.0377145370485, 2347.1315613223046, 2315.097112126272, 2351.094828491026, 2375.180562705864, 2378.096323397115, 2380.202632118225, 8130.430869839113, 8215.917840821576, 8224.0, 8225.629846656855, 8229.83540329196, 4909.459959404463, 5012.27322038306, 5055.595552355802, 5057.924131138036, 5060.0, 3157.747380209578, 3159.3681263747344, 3210.133264018725, 3231.0952933178514, 3250.951235731466, 1086.3916206924148, 2013.677811550145, 2064.3910046536307, 2069.0, 2107.2413930984835, 10876.238663293572, 10932.890671093346, 10971.396573188471, 10982.890171098266, 11011.669649910515, 4103.815328310174, 4287.935680964788, 4295.763732994716, 4339.848105316362, 4348.869533913988, 9060.093990600888, 9100.044495328028, 9106.134917182857, 9120.543972801333, 9128.08719128095, 4846.903061938741, 4864.878378040577, 4867.7322747249245, 4893.755312234445, 4905.3623029006, 3893.201893611803, 4331.6318112960125, 4357.237483440449, 4415.448068991376, 4416.227160247008, 3641.672249497505, 3692.7599706019023, 3720.330340538729, 3747.4191500317493, 3775.244951009809, 1046.3460337289193, 1049.9737506562396, 1051.7896420715888, 1068.647346375694, 1082.7617924056694, 1453.8546145385376, 1469.0, 1470.0224350806807, 1494.7757836324638, 1498.7901693762883, 8005.639746211435, 8006.679732810622, 8060.153683863227, 8063.717769878143, 8076.071251806, 504.73249177935753, 513.5095983335905, 514.63975217348, 516.8656149401182, 526.4472304080776, 6244.531660125509, 6288.339724328971, 6307.274663413675, 6423.4861211103, 6428.357164283628, 9683.176929960891, 10018.148457381205, 10051.59793608262, 10200.795984080276, 10214.182865370902, 9749.0, 9856.66934963785, 9944.950275248577, 9981.051800078982, 10040.046195611405, 7804.921950780419, 7811.140774514799, 7887.723929662549, 7997.120316765151, 8007.759767206993, 7714.807129821799, 7718.073831140299, 7759.68961241544, 7790.14308426084, 7839.216078392115, 8596.226339629464, 8914.33142514327, 9090.409123406956, 9187.586558604746, 9201.815963680823, 8911.643534258557, 9163.175314221751, 9170.174684278447, 9220.815583688423, 9353.39202951806, 6107.511399088151, 6262.499000079892, 6626.635535045619, 6862.073620061427, 6921.1002569665625, 7830.021247344082, 7830.725924592612, 7831.412644051605, 7882.763517094496, 7898.538770327508, 7080.575165490087, 7226.963865180641, 7233.0, 7292.270772922665, 7349.77950661481, 7182.174049984319, 7206.171290301473, 7211.819704507429, 7220.097487814023, 7285.235050319852, 7182.066331376887, 7240.456965727697, 7251.601161936144, 7256.129264488295, 7376.373008294355, 6557.508186886098, 6610.438112760469, 6612.933870661232, 6626.966865165643, 6640.236372817188, 6771.729130834909, 6899.137607799025, 6916.619585922823, 6918.515703900679, 7142.964285178541], "unit": "score", "name": "mootools.html", "value": 4640.054905804591}, {"lowerIsBetter": false, "replicates": [342.7523813319516, 347.1252443841519, 351.07841914973193, 352.8253514510316, 357.24264559134656, 6012.458878700916, 6039.939600603992, 6067.423594758502, 6077.665728384937, 6093.75624975001, 5980.671063091529, 5980.760769569223, 5989.580729348947, 5993.610415323001, 6029.366916473762, 4430.5126436092005, 4503.0318481526465, 4566.589006989387, 4614.007988282527, 4632.606228470584, 4591.885202869921, 4593.977030114861, 4616.238320677085, 4618.307253911907, 4632.189366860803, 4578.542145785428, 4580.7938642761155, 4582.060677561092, 4587.632989360844, 4617.584417402433, 4424.690271680967, 4512.3682684424375, 4575.977120114411, 4578.679492435531, 4631.096936097462, 4084.6936479764136, 4085.59144085592, 4090.611391917793, 4097.91804163918, 4098.221337945811, 5692.0608099663505, 5696.601237913348, 5698.51562617178, 5705.429457054262, 5713.914291285634, 5405.351357837046, 5411.296531450926, 5411.457734545675, 5428.348598168205, 5436.320459942507, 6351.174347334863, 6362.618242905441, 6364.649944253064, 6366.649834259114, 6367.681615919232, 4268.423762792046, 4378.605925466692, 4436.0, 4437.245668236407, 4532.524084971096, 6553.0, 6604.306547812506, 6611.867762644768, 6613.636250006248, 6624.304448032935, 4534.79593418297, 4535.63714902807, 4539.546045395434, 4543.4775000875325, 4551.6813823032735, 4594.035252596992, 4606.516315786861, 4609.239475486507, 4613.561711637389, 4624.421947256593, 5311.787528498817, 5325.786968521294, 5328.307320048369, 5333.333333333333, 5333.493318134771, 6304.590201636879, 6353.459955903708, 6387.297397286295, 6409.67951602418, 6429.54993150475, 1596.4811436283255, 1616.3373017062947, 1629.2505447494286, 1630.274527835102, 1637.148682684997, 1033.5245786937942, 1056.1234175634206, 1135.1543100390097, 1145.5131569083105, 1146.79357715612, 6075.726592303357, 6143.170671959318, 6146.170267013986, 6148.415900489446, 6155.292141403706, 6577.112089867806, 6586.473082153416, 6646.700898459581, 6650.800475985729, 6657.567258128303, 6134.693265336805, 6135.417135372132, 6138.171346868205, 6143.477804386677, 6147.815565533041, 3519.102628829632, 3552.662497062775, 3553.697935675445, 3554.0581745837376, 3559.056849934769, 6614.404703576702, 6747.0, 6762.154730658668, 6789.728410863609, 6790.42281406086, 6689.431398331099, 6695.363940425652, 6714.966425167843, 6728.495362847708, 6729.663516824139, 6737.191537015491, 6746.123004009545, 6758.76344327956, 6762.256151823295, 6768.560043597249, 6549.279579246374, 6561.311062338576, 6565.179352580927, 6566.080748695091, 6567.211934567882, 6287.402696743802, 6427.903581446376, 6428.55000149985, 6450.580712253689, 6461.903071454026, 6744.359285867835, 6760.966195168992, 6763.5941843489545, 6777.966110169417, 6784.084148640068, 4697.694649847749, 4702.27114797207, 4704.082703872712, 4706.082313948884, 4706.835260765857, 6549.836254093686, 6562.0, 6563.0811686364905, 6565.441937435371, 6575.178102737158, 6246.500279977682, 6363.872722545616, 6376.202974628171, 6381.425671689571, 6393.0, 6357.205349331333, 6378.649174295459, 6384.361563843579, 6385.425311721968, 6391.424771770563, 6293.339199383999, 6300.054991751274, 6304.18045654062, 6306.400891915261, 6307.590006649553, 6384.489240860627, 6412.038194270896, 6430.453411459891, 6439.774607888701, 6441.645709486023, 6043.456088952015, 6114.144019837137, 6273.843153921189, 6291.087792270004, 6378.840528986812], "unit": "score", "name": "prototype.html", "value": 4824.819487201793}, {"lowerIsBetter": false, "replicates": [825.2119226139038, 915.0346384564286, 931.5295775633305, 931.6413180925342, 961.7162936933604, 13934.163950162985, 14058.578242652737, 14085.295735213223, 14416.927915360422, 14547.345369458373, 13018.674533136676, 13843.653908652288, 14172.716545669105, 14173.858261417383, 14188.21964791936, 771.8610650082983, 942.853857652065, 944.4569372610742, 961.1109723505764, 971.0968799016912, 958.4584709639032, 963.02734238419, 963.2967933408615, 967.0474582536197, 968.70454511374, 1001.7846163074937, 1002.3234316836143, 1002.8144793213243, 1003.1222680154865, 1005.1456262177128, 803.9196080391972, 976.8241716491065, 990.1089019882164, 991.008991008991, 996.0388225362524, 724.5181954000583, 730.0764532865929, 731.4294850016995, 731.5720303622387, 733.3106879533221, 14226.359813808403, 14290.499162646494, 14366.928165359106, 14377.496787612383, 14384.928075359661, 13124.409401576951, 13255.023492952076, 13399.53101641438, 13477.19136851792, 13603.31983400826, 10891.67324980244, 10940.945295273472, 10984.340939543654, 11069.299310854916, 11174.553017879274, 3928.7249892507534, 3969.4641223435046, 3972.781497017663, 3973.543042550115, 3975.8210880510155, 51547.48452515502, 51651.483485165045, 51663.48336516662, 51687.22469162966, 51764.74117629388, 10384.896151038543, 11004.284721493077, 11482.196246262682, 11632.127590430751, 11748.58879939198, 19637.80362196388, 19753.308634197732, 19779.802201978084, 19794.0, 19823.207071717257, 8147.063087744867, 8221.218984196492, 8301.875471867927, 8332.791680207922, 8375.832483350421, 4584.564466375689, 4621.260598304255, 4765.523447655207, 4855.830045948375, 4947.505249475023, 3275.164832967578, 3315.2209230830736, 3317.8175200364212, 3323.2522682396266, 3328.86684532616, 580.8954388210078, 585.464300165344, 609.1360437062602, 613.8404014956144, 615.7352338494491, 558.6201383059478, 567.3758865248194, 620.8168590265882, 702.6486756621689, 706.9590350455269, 8976.640934362684, 9029.729108126767, 9067.09329067088, 9229.676961306457, 9235.676751313806, 649.9935000649933, 673.6025744810586, 715.1239731329081, 737.6053811210976, 764.900562926816, 4232.894177645522, 4309.6767742418815, 4310.137972405469, 4361.193179261847, 4421.624161946271, 61316.69341653263, 62063.6896815513, 62135.6893215531, 62388.688056559426, 62690.0, 56460.71769641126, 56645.43354566484, 57478.71260643753, 58320.4167958315, 58609.4139058604, 50499.0, 50520.74739626352, 50767.49232507627, 50820.99999999926, 51122.233166502534, 9151.17639412456, 9233.538323083952, 9233.769155771159, 9290.535473226448, 9382.718518444457, 37352.252954941294, 37353.43969840509, 37374.0, 38808.6119138805, 39419.605803941595, 45858.312125318815, 48989.51010489992, 49265.32325776647, 49760.502394975585, 50108.24837627366, 12063.0, 12097.032237421161, 12288.877111228774, 12457.626271211879, 12589.118761686594, 12958.352082395653, 13081.215127092404, 13402.128861623964, 13519.256440895846, 13619.86380136186, 12496.625101246977, 12522.624321270376, 12639.368031598568, 13152.934235328763, 13505.0, 12872.16330938486, 12961.935190324366, 12979.0, 13128.0, 13181.934090329487, 11785.528578856749, 11820.527178913091, 11897.107716921439, 12086.51653933868, 12802.463704355538, 10684.679459616224, 10884.782304354027, 10971.670849874517, 11053.0, 11343.659690209306, 10884.455777211266, 11131.944340278247, 11133.332000080021, 11147.888521114684, 11193.384363859741], "unit": "score", "name": "yui.html", "value": 6932.561158123393}], "name": "dromaeo_css", "value": 7301.385642755715}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 111.0, 111.0, 112.0, 101.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 151.0, 176.0, 126.0, 149.0, 151.0, 131.0, 186.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 160.0, 162.0, 160.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 162.0, 75.0, 76.0, 75.0, 75.0, 155.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 93.0, 93.0, 93.0, 146.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 58.0, 56.0, 57.0, 56.0, 57.0, 65.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 68.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 86.0, 79.0, 77.0, 85.0, 77.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [127.0, 111.0, 127.0, 110.0, 113.0, 111.0, 126.0, 122.0, 111.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [148.0, 137.0, 148.0, 132.0, 140.0, 132.0, 142.0, 140.0, 140.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 68.0, 64.0, 64.0, 65.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1499.6999999999998}]} 21:54:45 INFO - Return code: 0 21:54:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:54:45 INFO - # TBPL SUCCESS # 21:54:45 INFO - Running post-action listener: _resource_record_post_action 21:54:45 INFO - Running post-run listener: _resource_record_post_run 21:54:47 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 7946240; Write bytes: 394465280; Read time: 1412; Write time: 378596 21:54:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 20168704; Read time: 0; Write time: 17768 21:54:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 6184960; Write bytes: 374296576; Read time: 1360; Write time: 360828 21:54:47 INFO - Running post-run listener: _upload_blobber_files 21:54:47 INFO - Blob upload gear active. 21:54:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 21:54:47 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 21:54:47 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 21:54:47 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 21:54:47 INFO - (blobuploader) - INFO - Open directory for files ... 21:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 21:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:48 INFO - (blobuploader) - INFO - Done attempting. 21:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:49 INFO - (blobuploader) - INFO - Done attempting. 21:54:49 INFO - (blobuploader) - INFO - Iteration through files over. 21:54:49 INFO - Return code: 0 21:54:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 21:54:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 21:54:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d346cd293f063da2280edcc686ea82142c69636e21b4bbbeadcca76ea31d6320d48b8dd3636cc4bf0bdb7614280e03fb565a999dd6d69170ec8b047b03b4cfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df78ff163edfca08d7a09779af2fc7af396ad9b5d91db4c618e0a6b20d1821928414028f77e6398941f746545373fb183f4d4b480278686035645f4f8fe037b9"} 21:54:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 21:54:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 21:54:49 INFO - Contents: 21:54:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d346cd293f063da2280edcc686ea82142c69636e21b4bbbeadcca76ea31d6320d48b8dd3636cc4bf0bdb7614280e03fb565a999dd6d69170ec8b047b03b4cfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df78ff163edfca08d7a09779af2fc7af396ad9b5d91db4c618e0a6b20d1821928414028f77e6398941f746545373fb183f4d4b480278686035645f4f8fe037b9"} 21:54:49 INFO - Running post-run listener: copy_logs_to_upload_dir 21:54:49 INFO - Copying logs to upload dir... 21:54:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 21:54:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.366349 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-17 21:54:49.329320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 21:54:49.332694) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 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-Aurora/sha512/d346cd293f063da2280edcc686ea82142c69636e21b4bbbeadcca76ea31d6320d48b8dd3636cc4bf0bdb7614280e03fb565a999dd6d69170ec8b047b03b4cfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df78ff163edfca08d7a09779af2fc7af396ad9b5d91db4c618e0a6b20d1821928414028f77e6398941f746545373fb183f4d4b480278686035645f4f8fe037b9"} build_url:https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/Wnv1wZ86TDSvrFk6JPCsdg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d346cd293f063da2280edcc686ea82142c69636e21b4bbbeadcca76ea31d6320d48b8dd3636cc4bf0bdb7614280e03fb565a999dd6d69170ec8b047b03b4cfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df78ff163edfca08d7a09779af2fc7af396ad9b5d91db4c618e0a6b20d1821928414028f77e6398941f746545373fb183f4d4b480278686035645f4f8fe037b9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 21:54:49.358209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:54:49.358546) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458275656.542788-842791550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 21:54:49.445079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 21:54:49.445856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 21:54:49.446581) ========= ========= Total master_lag: 0.13 =========