builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1458145325.03 results: success (0) buildid: 20160316065251 builduid: 06b0f9453ee042e1b87366e314b7b843 revision: c3d63e1cfd6ef1d388af123eb3bc99d4703205ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.030227) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.030731) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.031082) ========= 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006332 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.057644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.057966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.076929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.077286) ========= 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.127516) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.127906) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.128322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.128685) ========= 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 09:22:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.0M=0s 2016-03-16 09:22:05 (70.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.304283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.304626) ========= 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.226297 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.547677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:05.548031) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3d63e1cfd6ef1d388af123eb3bc99d4703205ca --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 c3d63e1cfd6ef1d388af123eb3bc99d4703205ca --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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 09:22:05,671 truncating revision to first 12 chars 2016-03-16 09:22:05,671 Setting DEBUG logging. 2016-03-16 09:22:05,671 attempt 1/10 2016-03-16 09:22:05,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c3d63e1cfd6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 09:22:06,008 unpacking tar archive at: mozilla-aurora-c3d63e1cfd6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:06.183623) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:06.183973) ========= echo c3d63e1cfd6ef1d388af123eb3bc99d4703205ca in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c3d63e1cfd6ef1d388af123eb3bc99d4703205ca'] 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c3d63e1cfd6ef1d388af123eb3bc99d4703205ca program finished with exit code 0 elapsedTime=0.004693 script_repo_revision: 'c3d63e1cfd6ef1d388af123eb3bc99d4703205ca' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:06.235204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:06.235547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 09:22:06.256703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-16 09:22:06.257018) ========= /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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:06 INFO - MultiFileLogger online at 20160316 09:22:06 in /builds/slave/test-pgo 09:22:06 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 09:22:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:22:06 INFO - {'append_to_log': False, 09:22:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:22:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:22:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:22:06 INFO - 'branch': 'Mozilla-Aurora', 09:22:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:06 INFO - 'config_files': ('talos/linux_config.py',), 09:22:06 INFO - 'default_actions': ('clobber', 09:22:06 INFO - 'read-buildbot-config', 09:22:06 INFO - 'download-and-extract', 09:22:06 INFO - 'populate-webroot', 09:22:06 INFO - 'create-virtualenv', 09:22:06 INFO - 'install', 09:22:06 INFO - 'run-tests'), 09:22:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:06 INFO - 'download_minidump_stackwalk': True, 09:22:06 INFO - 'download_symbols': 'ondemand', 09:22:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:06 INFO - 'installer_path': 'installer.exe', 09:22:06 INFO - 'log_level': 'info', 09:22:06 INFO - 'log_name': 'talos', 09:22:06 INFO - 'log_to_console': True, 09:22:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:06 INFO - 'opt_config_files': (), 09:22:06 INFO - 'pip_index': False, 09:22:06 INFO - 'sps_profile': False, 09:22:06 INFO - 'sps_profile_interval': 0, 09:22:06 INFO - 'suite': 'dromaeojs', 09:22:06 INFO - 'system_bits': '32', 09:22:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:06 INFO - 'title': 'talos-linux64-ix-026', 09:22:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:06 INFO - 'use_talos_json': True, 09:22:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:22:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:06 INFO - 'work_dir': 'build'} 09:22:06 INFO - ##### 09:22:06 INFO - ##### Running clobber step. 09:22:06 INFO - ##### 09:22:06 INFO - Running pre-action listener: _resource_record_pre_action 09:22:06 INFO - Running main action method: clobber 09:22:06 INFO - rmtree: /builds/slave/test-pgo/build 09:22:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:22:07 INFO - Running post-action listener: _resource_record_post_action 09:22:07 INFO - ##### 09:22:07 INFO - ##### Running read-buildbot-config step. 09:22:07 INFO - ##### 09:22:07 INFO - Running pre-action listener: _resource_record_pre_action 09:22:07 INFO - Running main action method: read_buildbot_config 09:22:07 INFO - Using buildbot properties: 09:22:07 INFO - { 09:22:07 INFO - "project": "", 09:22:07 INFO - "product": "firefox", 09:22:07 INFO - "script_repo_revision": "production", 09:22:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:22:07 INFO - "repository": "", 09:22:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:22:07 INFO - "buildid": "20160316065251", 09:22:07 INFO - "pgo_build": "True", 09:22:07 INFO - "basedir": "/builds/slave/test-pgo", 09:22:07 INFO - "buildnumber": 116, 09:22:07 INFO - "slavename": "talos-linux64-ix-026", 09:22:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:22:07 INFO - "platform": "ubuntu64_hw", 09:22:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:22:07 INFO - "branch": "mozilla-aurora", 09:22:07 INFO - "repo_path": "releases/mozilla-aurora", 09:22:07 INFO - "revision": "c3d63e1cfd6ef1d388af123eb3bc99d4703205ca", 09:22:07 INFO - "stage_platform": "linux64-pgo", 09:22:07 INFO - "builduid": "06b0f9453ee042e1b87366e314b7b843", 09:22:07 INFO - "slavebuilddir": "test" 09:22:07 INFO - } 09:22:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:22:07 INFO - Running post-action listener: _resource_record_post_action 09:22:07 INFO - ##### 09:22:07 INFO - ##### Running download-and-extract step. 09:22:07 INFO - ##### 09:22:07 INFO - Running pre-action listener: _resource_record_pre_action 09:22:07 INFO - Running main action method: download_and_extract 09:22:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:07 INFO - https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:08 INFO - Downloaded 1448 bytes. 09:22:08 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:22:08 INFO - Using the following test package requirements: 09:22:08 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:08 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:22:08 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:22:08 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'jsshell-linux-x86_64.zip'], 09:22:08 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:22:08 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:08 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:22:08 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:22:08 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:22:08 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:08 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:22:08 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:08 INFO - https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:22:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:22:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:10 INFO - Downloaded 23308418 bytes. 09:22:10 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'] 09:22:10 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 09:22:12 INFO - Return code: 0 09:22:12 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 09:22: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')]} 09:22:12 INFO - https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:22 INFO - Downloaded 23308418 bytes. 09:22: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'] 09:22: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 09:22:23 INFO - Return code: 0 09:22: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')]} 09:22:23 INFO - https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:24 INFO - Downloaded 10845161 bytes. 09:22:24 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'] 09:22:24 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 09:22:24 INFO - Return code: 0 09:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:24 INFO - https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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 09:22:26 INFO - Downloaded 60442095 bytes. 09:22:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:22:26 INFO - mkdir: /builds/slave/test-pgo/properties 09:22:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:22:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:22:26 INFO - Contents: 09:22:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:22:27 INFO - Running post-action listener: _resource_record_post_action 09:22:27 INFO - Running post-action listener: set_extra_try_arguments 09:22:27 INFO - ##### 09:22:27 INFO - ##### Running populate-webroot step. 09:22:27 INFO - ##### 09:22:27 INFO - Running pre-action listener: _resource_record_pre_action 09:22:27 INFO - Running main action method: populate_webroot 09:22:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:27 INFO - '--tppagecycles', 09:22:27 INFO - '7'], 09:22:27 INFO - 'tests': ['tsvgm']}}, 09:22:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:22:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:22:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:22:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'tests': ['damp', 'tps']}, 09:22:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['damp', 'tps']}, 09:22:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:22:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:27 INFO - 'other': {'tests': ['a11yr', 09:22:27 INFO - 'ts_paint', 09:22:27 INFO - 'tpaint', 09:22:27 INFO - 'sessionrestore', 09:22:27 INFO - 'sessionrestore_no_auto_restore', 09:22:27 INFO - 'tabpaint']}, 09:22:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['a11yr', 09:22:27 INFO - 'ts_paint', 09:22:27 INFO - 'tpaint', 09:22:27 INFO - 'sessionrestore', 09:22:27 INFO - 'sessionrestore_no_auto_restore', 09:22:27 INFO - 'tabpaint']}, 09:22:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['a11yr', 09:22:27 INFO - 'ts_paint', 09:22:27 INFO - 'tpaint', 09:22:27 INFO - 'sessionrestore', 09:22:27 INFO - 'sessionrestore_no_auto_restore', 09:22:27 INFO - 'tabpaint']}, 09:22:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['a11yr', 09:22:27 INFO - 'ts_paint', 09:22:27 INFO - 'tpaint', 09:22:27 INFO - 'sessionrestore', 09:22:27 INFO - 'sessionrestore_no_auto_restore', 09:22:27 INFO - 'tabpaint']}, 09:22:27 INFO - 'other_l64': {'tests': ['a11yr', 09:22:27 INFO - 'ts_paint', 09:22:27 INFO - 'tpaint', 09:22:27 INFO - 'sessionrestore', 09:22:27 INFO - 'sessionrestore_no_auto_restore', 09:22:27 INFO - 'tabpaint']}, 09:22:27 INFO - 'other_nol64': {'tests': ['a11yr', 09:22:27 INFO - 'ts_paint', 09:22:27 INFO - 'tpaint', 09:22:27 INFO - 'sessionrestore', 09:22:27 INFO - 'sessionrestore_no_auto_restore', 09:22:27 INFO - 'tabpaint']}, 09:22:27 INFO - 'svgr': {'tests': ['tsvgx', 09:22:27 INFO - 'tsvgr_opacity', 09:22:27 INFO - 'tart', 09:22:27 INFO - 'tscrollx', 09:22:27 INFO - 'cart']}, 09:22:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['tsvgx', 09:22:27 INFO - 'tsvgr_opacity', 09:22:27 INFO - 'tart', 09:22:27 INFO - 'tscrollx', 09:22:27 INFO - 'cart']}, 09:22:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'tests': ['tp5o']}, 09:22:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'talos_options': ['--e10s'], 09:22:27 INFO - 'tests': ['tp5o']}, 09:22:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'talos_options': ['--xperf_path', 09:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:27 INFO - 'tests': ['tp5n']}, 09:22:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:27 INFO - 'talos_options': ['--e10s', 09:22:27 INFO - '--xperf_path', 09:22:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:27 INFO - 'tests': ['tp5n']}}, 09:22:27 INFO - 'talos.zip': {'path': '', 09:22:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:27 INFO - Running post-action listener: _resource_record_post_action 09:22:27 INFO - ##### 09:22:27 INFO - ##### Running create-virtualenv step. 09:22:27 INFO - ##### 09:22:27 INFO - Running pre-action listener: _resource_record_pre_action 09:22:27 INFO - Running main action method: create_virtualenv 09:22:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:22:27 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 09:22:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:22:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:27 INFO - Using real prefix '/usr' 09:22:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:22:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:29 INFO - Installing pip.................done. 09:22:29 INFO - Return code: 0 09:22:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:22:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:22:29 INFO - Using env: {'DISPLAY': ':0', 09:22:29 INFO - 'HOME': '/home/cltbld', 09:22:29 INFO - 'LANG': 'en_US.UTF-8', 09:22:29 INFO - 'LANGUAGE': 'en_US:en', 09:22:29 INFO - 'LOGNAME': 'cltbld', 09:22:29 INFO - 'MAIL': '/var/mail/cltbld', 09:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:29 INFO - 'MOZ_NO_REMOTE': '1', 09:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:29 INFO - 'NO_EM_RESTART': '1', 09:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:29 INFO - 'SHELL': '/bin/bash', 09:22:29 INFO - 'SHLVL': '1', 09:22:29 INFO - 'TERM': 'linux', 09:22:29 INFO - 'TMOUT': '86400', 09:22:29 INFO - 'USER': 'cltbld', 09:22:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:29 INFO - '_': '/tools/buildbot/bin/python'} 09:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:29 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 09:22:29 INFO - Cleaning up... 09:22:29 INFO - Return code: 0 09:22:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:22:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:22:29 INFO - Using env: {'DISPLAY': ':0', 09:22:29 INFO - 'HOME': '/home/cltbld', 09:22:29 INFO - 'LANG': 'en_US.UTF-8', 09:22:29 INFO - 'LANGUAGE': 'en_US:en', 09:22:29 INFO - 'LOGNAME': 'cltbld', 09:22:29 INFO - 'MAIL': '/var/mail/cltbld', 09:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:29 INFO - 'MOZ_NO_REMOTE': '1', 09:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:29 INFO - 'NO_EM_RESTART': '1', 09:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:29 INFO - 'SHELL': '/bin/bash', 09:22:29 INFO - 'SHLVL': '1', 09:22:29 INFO - 'TERM': 'linux', 09:22:29 INFO - 'TMOUT': '86400', 09:22:29 INFO - 'USER': 'cltbld', 09:22:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:29 INFO - '_': '/tools/buildbot/bin/python'} 09:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:30 INFO - Downloading/unpacking psutil>=0.7.1 09:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:32 INFO - Installing collected packages: psutil 09:22:32 INFO - Running setup.py install for psutil 09:22:32 INFO - building 'psutil._psutil_linux' extension 09:22:32 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 09:22:32 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 09:22:32 INFO - building 'psutil._psutil_posix' extension 09:22:32 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 09:22:32 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 09:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:32 INFO - Successfully installed psutil 09:22:32 INFO - Cleaning up... 09:22:32 INFO - Return code: 0 09:22:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:22:32 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')]} 09:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:32 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')]} 09:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:32 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:32 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 09:22:32 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 09:22:32 INFO - Using env: {'DISPLAY': ':0', 09:22:32 INFO - 'HOME': '/home/cltbld', 09:22:32 INFO - 'LANG': 'en_US.UTF-8', 09:22:32 INFO - 'LANGUAGE': 'en_US:en', 09:22:32 INFO - 'LOGNAME': 'cltbld', 09:22:32 INFO - 'MAIL': '/var/mail/cltbld', 09:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:32 INFO - 'MOZ_NO_REMOTE': '1', 09:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:32 INFO - 'NO_EM_RESTART': '1', 09:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:32 INFO - 'SHELL': '/bin/bash', 09:22:32 INFO - 'SHLVL': '1', 09:22:32 INFO - 'TERM': 'linux', 09:22:32 INFO - 'TMOUT': '86400', 09:22:32 INFO - 'USER': 'cltbld', 09:22:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:32 INFO - '_': '/tools/buildbot/bin/python'} 09:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:22:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:22:34 INFO - Installing collected packages: mozsystemmonitor 09:22:34 INFO - Running setup.py install for mozsystemmonitor 09:22:34 INFO - Successfully installed mozsystemmonitor 09:22:34 INFO - Cleaning up... 09:22:34 INFO - Return code: 0 09:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:22:34 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')]} 09:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:34 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')]} 09:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:34 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:34 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 09:22:34 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 09:22:34 INFO - Using env: {'DISPLAY': ':0', 09:22:34 INFO - 'HOME': '/home/cltbld', 09:22:34 INFO - 'LANG': 'en_US.UTF-8', 09:22:34 INFO - 'LANGUAGE': 'en_US:en', 09:22:34 INFO - 'LOGNAME': 'cltbld', 09:22:34 INFO - 'MAIL': '/var/mail/cltbld', 09:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:34 INFO - 'MOZ_NO_REMOTE': '1', 09:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:34 INFO - 'NO_EM_RESTART': '1', 09:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:34 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:34 INFO - 'SHELL': '/bin/bash', 09:22:34 INFO - 'SHLVL': '1', 09:22:34 INFO - 'TERM': 'linux', 09:22:34 INFO - 'TMOUT': '86400', 09:22:34 INFO - 'USER': 'cltbld', 09:22:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:34 INFO - '_': '/tools/buildbot/bin/python'} 09:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:37 INFO - Downloading docopt-0.6.1.tar.gz 09:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:37 INFO - Running setup.py install for blobuploader 09:22:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:22:37 INFO - Running setup.py install for requests 09:22:38 INFO - Running setup.py install for docopt 09:22:38 INFO - Successfully installed blobuploader requests docopt 09:22:38 INFO - Cleaning up... 09:22:38 INFO - Return code: 0 09:22:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22: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')]} 09:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:38 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:38 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 09:22:38 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 09:22:38 INFO - Using env: {'DISPLAY': ':0', 09:22:38 INFO - 'HOME': '/home/cltbld', 09:22:38 INFO - 'LANG': 'en_US.UTF-8', 09:22:38 INFO - 'LANGUAGE': 'en_US:en', 09:22:38 INFO - 'LOGNAME': 'cltbld', 09:22:38 INFO - 'MAIL': '/var/mail/cltbld', 09:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:38 INFO - 'MOZ_NO_REMOTE': '1', 09:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:38 INFO - 'NO_EM_RESTART': '1', 09:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:38 INFO - 'SHELL': '/bin/bash', 09:22:38 INFO - 'SHLVL': '1', 09:22:38 INFO - 'TERM': 'linux', 09:22:38 INFO - 'TMOUT': '86400', 09:22:38 INFO - 'USER': 'cltbld', 09:22:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:38 INFO - '_': '/tools/buildbot/bin/python'} 09:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:38 INFO - Running setup.py (path:/tmp/pip-Ovxo2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:38 INFO - Running setup.py (path:/tmp/pip-gtenXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:38 INFO - Running setup.py (path:/tmp/pip-6mkQFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:38 INFO - Running setup.py (path:/tmp/pip-8sMLjp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:38 INFO - Running setup.py (path:/tmp/pip-2jksmM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:38 INFO - Running setup.py (path:/tmp/pip-AdoR04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:39 INFO - Running setup.py (path:/tmp/pip-x4qUOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:39 INFO - Running setup.py (path:/tmp/pip-h6X0l7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:39 INFO - Running setup.py (path:/tmp/pip-hyOB21-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:39 INFO - Running setup.py (path:/tmp/pip-2G7fSu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:39 INFO - Running setup.py (path:/tmp/pip-Xy_zU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:39 INFO - Running setup.py (path:/tmp/pip-LyzZqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:39 INFO - Running setup.py (path:/tmp/pip-qzL7Yt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:39 INFO - Running setup.py (path:/tmp/pip-oI61Ql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:39 INFO - Running setup.py (path:/tmp/pip-PENYK8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:39 INFO - Running setup.py (path:/tmp/pip-aj_jEQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:39 INFO - Running setup.py (path:/tmp/pip-UKh_jI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:39 INFO - Running setup.py install for manifestparser 09:22:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozcrash 09:22:39 INFO - Running setup.py install for mozdebug 09:22:40 INFO - Running setup.py install for mozdevice 09:22:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Running setup.py install for mozfile 09:22:40 INFO - Running setup.py install for mozhttpd 09:22:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Running setup.py install for mozinfo 09:22:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Running setup.py install for mozInstall 09:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Running setup.py install for mozleak 09:22:40 INFO - Running setup.py install for mozlog 09:22:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Running setup.py install for moznetwork 09:22:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Running setup.py install for mozprocess 09:22:41 INFO - Running setup.py install for mozprofile 09:22:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:22:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:22:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:22:41 INFO - Running setup.py install for mozrunner 09:22:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:22:41 INFO - Running setup.py install for mozscreenshot 09:22:41 INFO - Running setup.py install for moztest 09:22:41 INFO - Running setup.py install for mozversion 09:22:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:41 INFO - Cleaning up... 09:22:41 INFO - Return code: 0 09:22:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22: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')]} 09:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:41 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:41 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 09:22:41 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 09:22:41 INFO - Using env: {'DISPLAY': ':0', 09:22:41 INFO - 'HOME': '/home/cltbld', 09:22:41 INFO - 'LANG': 'en_US.UTF-8', 09:22:41 INFO - 'LANGUAGE': 'en_US:en', 09:22:41 INFO - 'LOGNAME': 'cltbld', 09:22:41 INFO - 'MAIL': '/var/mail/cltbld', 09:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:41 INFO - 'MOZ_NO_REMOTE': '1', 09:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:41 INFO - 'NO_EM_RESTART': '1', 09:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:41 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:41 INFO - 'SHELL': '/bin/bash', 09:22:41 INFO - 'SHLVL': '1', 09:22:41 INFO - 'TERM': 'linux', 09:22:41 INFO - 'TMOUT': '86400', 09:22:41 INFO - 'USER': 'cltbld', 09:22:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:41 INFO - '_': '/tools/buildbot/bin/python'} 09:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:41 INFO - Running setup.py (path:/tmp/pip-kZPZyc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:41 INFO - Running setup.py (path:/tmp/pip-ULFWGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:41 INFO - Running setup.py (path:/tmp/pip-EFVrAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:42 INFO - Running setup.py (path:/tmp/pip-AkPIN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:42 INFO - Running setup.py (path:/tmp/pip-otwZqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:42 INFO - Running setup.py (path:/tmp/pip-SYymtU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:42 INFO - Running setup.py (path:/tmp/pip-XzxyLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:42 INFO - Running setup.py (path:/tmp/pip-lViUiY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:42 INFO - Running setup.py (path:/tmp/pip-GO19ch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:42 INFO - Running setup.py (path:/tmp/pip-l4aPGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:42 INFO - Running setup.py (path:/tmp/pip-sTFpfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:42 INFO - Running setup.py (path:/tmp/pip-xd10Fq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:42 INFO - Running setup.py (path:/tmp/pip-IenWdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:42 INFO - Running setup.py (path:/tmp/pip-DrxEJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:42 INFO - Running setup.py (path:/tmp/pip-USJzYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:42 INFO - Running setup.py (path:/tmp/pip-VDKI8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:42 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)) 09:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:42 INFO - Running setup.py (path:/tmp/pip-mpDKqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:43 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)) 09:22:43 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)) 09:22:43 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)) 09:22:43 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)) 09:22:43 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)) 09:22:43 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)) 09:22:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:44 INFO - Downloading blessings-1.6.tar.gz 09:22:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:44 INFO - Installing collected packages: blessings 09:22:44 INFO - Running setup.py install for blessings 09:22:45 INFO - Successfully installed blessings 09:22:45 INFO - Cleaning up... 09:22:45 INFO - Return code: 0 09:22:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:22:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:22:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:22:45 INFO - Reading from file tmpfile_stdout 09:22:45 INFO - Current package versions: 09:22:45 INFO - argparse == 1.2.1 09:22:45 INFO - blessings == 1.6 09:22:45 INFO - blobuploader == 1.2.4 09:22:45 INFO - docopt == 0.6.1 09:22:45 INFO - manifestparser == 1.1 09:22:45 INFO - mozInstall == 1.12 09:22:45 INFO - mozcrash == 0.17 09:22:45 INFO - mozdebug == 0.1 09:22:45 INFO - mozdevice == 0.48 09:22:45 INFO - mozfile == 1.2 09:22:45 INFO - mozhttpd == 0.7 09:22:45 INFO - mozinfo == 0.9 09:22:45 INFO - mozleak == 0.1 09:22:45 INFO - mozlog == 3.1 09:22:45 INFO - moznetwork == 0.27 09:22:45 INFO - mozprocess == 0.22 09:22:45 INFO - mozprofile == 0.28 09:22:45 INFO - mozrunner == 6.11 09:22:45 INFO - mozscreenshot == 0.1 09:22:45 INFO - mozsystemmonitor == 0.0 09:22:45 INFO - moztest == 0.7 09:22:45 INFO - mozversion == 1.4 09:22:45 INFO - psutil == 3.1.1 09:22:45 INFO - requests == 1.2.3 09:22:45 INFO - wsgiref == 0.1.2 09:22:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22:45 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')]} 09:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:45 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')]} 09:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:45 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:45 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 09:22:45 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 09:22:45 INFO - Using env: {'DISPLAY': ':0', 09:22:45 INFO - 'HOME': '/home/cltbld', 09:22:45 INFO - 'LANG': 'en_US.UTF-8', 09:22:45 INFO - 'LANGUAGE': 'en_US:en', 09:22:45 INFO - 'LOGNAME': 'cltbld', 09:22:45 INFO - 'MAIL': '/var/mail/cltbld', 09:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:45 INFO - 'MOZ_NO_REMOTE': '1', 09:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:45 INFO - 'NO_EM_RESTART': '1', 09:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:45 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:45 INFO - 'SHELL': '/bin/bash', 09:22:45 INFO - 'SHLVL': '1', 09:22:45 INFO - 'TERM': 'linux', 09:22:45 INFO - 'TMOUT': '86400', 09:22:45 INFO - 'USER': 'cltbld', 09:22:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:45 INFO - '_': '/tools/buildbot/bin/python'} 09:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 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)) 09:22:45 INFO - Cleaning up... 09:22:45 INFO - Return code: 0 09:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:22:45 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')]} 09:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:45 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')]} 09:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:45 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:45 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 09:22:45 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 09:22:45 INFO - Using env: {'DISPLAY': ':0', 09:22:45 INFO - 'HOME': '/home/cltbld', 09:22:45 INFO - 'LANG': 'en_US.UTF-8', 09:22:45 INFO - 'LANGUAGE': 'en_US:en', 09:22:45 INFO - 'LOGNAME': 'cltbld', 09:22:45 INFO - 'MAIL': '/var/mail/cltbld', 09:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:45 INFO - 'MOZ_NO_REMOTE': '1', 09:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:45 INFO - 'NO_EM_RESTART': '1', 09:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:45 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:45 INFO - 'SHELL': '/bin/bash', 09:22:45 INFO - 'SHLVL': '1', 09:22:45 INFO - 'TERM': 'linux', 09:22:45 INFO - 'TMOUT': '86400', 09:22:45 INFO - 'USER': 'cltbld', 09:22:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:45 INFO - '_': '/tools/buildbot/bin/python'} 09:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:45 INFO - Downloading/unpacking jsonschema 09:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:47 INFO - Downloading/unpacking functools32 (from jsonschema) 09:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:47 INFO - warning: no files found matching '*.txt' 09:22:47 INFO - no previously-included directories found matching 'build' 09:22:47 INFO - no previously-included directories found matching 'dist' 09:22:47 INFO - no previously-included directories found matching '.git*' 09:22:47 INFO - Installing collected packages: jsonschema, functools32 09:22:47 INFO - Running setup.py install for functools32 09:22:47 INFO - warning: no files found matching '*.txt' 09:22:47 INFO - no previously-included directories found matching 'build' 09:22:47 INFO - no previously-included directories found matching 'dist' 09:22:47 INFO - no previously-included directories found matching '.git*' 09:22:48 INFO - Successfully installed jsonschema functools32 09:22:48 INFO - Cleaning up... 09:22:48 INFO - Return code: 0 09:22:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:48 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 0x7f36524e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, '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': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', '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 09:22:48 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 09:22:48 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 09:22:48 INFO - Using env: {'DISPLAY': ':0', 09:22:48 INFO - 'HOME': '/home/cltbld', 09:22:48 INFO - 'LANG': 'en_US.UTF-8', 09:22:48 INFO - 'LANGUAGE': 'en_US:en', 09:22:48 INFO - 'LOGNAME': 'cltbld', 09:22:48 INFO - 'MAIL': '/var/mail/cltbld', 09:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:48 INFO - 'MOZ_NO_REMOTE': '1', 09:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:48 INFO - 'NO_EM_RESTART': '1', 09:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:48 INFO - 'SHELL': '/bin/bash', 09:22:48 INFO - 'SHLVL': '1', 09:22:48 INFO - 'TERM': 'linux', 09:22:48 INFO - 'TMOUT': '86400', 09:22:48 INFO - 'USER': 'cltbld', 09:22:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:48 INFO - '_': '/tools/buildbot/bin/python'} 09:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:48 INFO - Downloading/unpacking flake8 09:22:48 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 09:22:48 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 09:22:48 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 09:22:48 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 09:22:48 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 09:22:48 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 09:22:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:22:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:22:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:50 INFO - no previously-included directories found matching 'docs/_build' 09:22:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:22:50 INFO - Running setup.py install for pep8 09:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:50 INFO - no previously-included directories found matching 'docs/_build' 09:22:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:22:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:22:50 INFO - Cleaning up... 09:22:51 INFO - Return code: 0 09:22:51 INFO - Running post-action listener: _resource_record_post_action 09:22:51 INFO - Running post-action listener: _start_resource_monitoring 09:22:51 INFO - Starting resource monitoring. 09:22:51 INFO - ##### 09:22:51 INFO - ##### Running install step. 09:22:51 INFO - ##### 09:22:51 INFO - Running pre-action listener: _resource_record_pre_action 09:22:51 INFO - Running main action method: install 09:22:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:22:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:22:51 INFO - Reading from file tmpfile_stdout 09:22:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:22:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:22:51 INFO - Reading from file tmpfile_stdout 09:22:51 INFO - Output received: 09:22:51 INFO - Usage: mozinstall [options] installer 09:22:51 INFO - Options: 09:22:51 INFO - -h, --help show this help message and exit 09:22:51 INFO - -d DEST, --destination=DEST 09:22:51 INFO - Directory to install application into. [default: 09:22:51 INFO - "/builds/slave/test-pgo"] 09:22:51 INFO - --app=APP Application being installed. [default: firefox] 09:22:51 INFO - mkdir: /builds/slave/test-pgo/build/application 09:22:51 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'] 09:22:51 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 09:23:06 INFO - Reading from file tmpfile_stdout 09:23:06 INFO - Output received: 09:23:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:23:06 INFO - Running post-action listener: _resource_record_post_action 09:23:06 INFO - ##### 09:23:06 INFO - ##### Running run-tests step. 09:23:06 INFO - ##### 09:23:06 INFO - Running pre-action listener: _resource_record_pre_action 09:23:06 INFO - Running main action method: run_tests 09:23:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:23:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:23:06 INFO - Python 2.7.3 09:23:06 INFO - Return code: 0 09:23:06 INFO - grabbing minidump binary from tooltool 09:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:06 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 0x25e1920>, '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 0x25e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:23:06 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 09:23:06 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 09:23:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:06 INFO - Return code: 0 09:23:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:23:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:23:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:23:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:23:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:23:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:23:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:23:07 INFO - Return code: 0 09:23:07 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/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:23:07 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/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 09:23:07 INFO - Using env: {'DISPLAY': ':0', 09:23:07 INFO - 'HOME': '/home/cltbld', 09:23:07 INFO - 'LANG': 'en_US.UTF-8', 09:23:07 INFO - 'LANGUAGE': 'en_US:en', 09:23:07 INFO - 'LOGNAME': 'cltbld', 09:23:07 INFO - 'MAIL': '/var/mail/cltbld', 09:23:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:23:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:07 INFO - 'MOZ_NO_REMOTE': '1', 09:23:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:07 INFO - 'NO_EM_RESTART': '1', 09:23:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:07 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:23:07 INFO - 'SHELL': '/bin/bash', 09:23:07 INFO - 'SHLVL': '1', 09:23:07 INFO - 'TERM': 'linux', 09:23:07 INFO - 'TMOUT': '86400', 09:23:07 INFO - 'USER': 'cltbld', 09:23:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100', 09:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:07 INFO - '_': '/tools/buildbot/bin/python'} 09:23:07 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/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:23:07 INFO - mozversion application_buildid: 20160316065251 09:23:07 INFO - mozversion application_changeset: c3d63e1cfd6ef1d388af123eb3bc99d4703205ca 09:23:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:07 INFO - mozversion application_name: Firefox 09:23:07 INFO - mozversion application_remotingname: firefox-dev 09:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:23:07 INFO - mozversion application_vendor: Mozilla 09:23:07 INFO - mozversion application_version: 47.0a2 09:23:07 INFO - mozversion platform_buildid: 20160316065251 09:23:07 INFO - mozversion platform_changeset: c3d63e1cfd6ef1d388af123eb3bc99d4703205ca 09:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:23:07 INFO - mozversion platform_version: 47.0a2 09:23:07 INFO - using testdate: 1458145387 09:23:07 INFO - actual date: 1458145387 09:23:07 INFO - starting webserver on 'localhost:44613' 09:23:07 INFO - SUITE-START | Running 2 tests 09:23:07 INFO - TEST-START | dromaeo_css 09:23:07 INFO - operating with platform_type : linux_ 09:23:07 INFO - Initialising browser for dromaeo_css test... 09:23:07 INFO - TEST-INFO | started process 7593 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphZRK38/profile http://localhost:44613/getInfo.html) 09:23:11 INFO - PROCESS | 7593 | __metrics Screen width/height:1600/1200 09:23:11 INFO - PROCESS | 7593 | colorDepth:24 09:23:11 INFO - PROCESS | 7593 | Browser inner width/height: 1024/697 09:23:11 INFO - PROCESS | 7593 | __metrics 09:23:12 INFO - PROCESS | 7593 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:23:13 INFO - TEST-INFO | 7593: exit 0 09:23:13 INFO - Browser initialized. 09:23:13 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:13 INFO - TEST-INFO | started process 7686 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphZRK38/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:25 INFO - PROCESS | 7686 | RSS: Main: 143507456 09:23:25 INFO - PROCESS | 7686 | 09:24:15 INFO - PROCESS | 7686 | 1458145455912 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] 09:26:23 INFO - PROCESS | 7686 | Cycle 1(1): loaded http://localhost:44613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44613/tests/dromaeo/cssquery-ext.html) 09:26:24 INFO - PROCESS | 7686 | RSS: Main: 247799808 09:26:24 INFO - PROCESS | 7686 | 09:29:26 INFO - PROCESS | 7686 | Cycle 1(1): loaded http://localhost:44613/tests/dromaeo/cssquery-ext.html (next: http://localhost:44613/tests/dromaeo/cssquery-jquery.html) 09:29:27 INFO - PROCESS | 7686 | RSS: Main: 220028928 09:29:27 INFO - PROCESS | 7686 | 09:32:29 INFO - PROCESS | 7686 | Cycle 1(1): loaded http://localhost:44613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44613/tests/dromaeo/cssquery-mootools.html) 09:32:29 INFO - PROCESS | 7686 | RSS: Main: 215994368 09:32:29 INFO - PROCESS | 7686 | 09:35:31 INFO - PROCESS | 7686 | Cycle 1(1): loaded http://localhost:44613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44613/tests/dromaeo/cssquery-prototype.html) 09:35:32 INFO - PROCESS | 7686 | RSS: Main: 207667200 09:35:32 INFO - PROCESS | 7686 | 09:38:34 INFO - PROCESS | 7686 | Cycle 1(1): loaded http://localhost:44613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44613/tests/dromaeo/cssquery-yui.html) 09:38:35 INFO - PROCESS | 7686 | RSS: Main: 209506304 09:38:35 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | Cycle 1(1): loaded http://localhost:44613/tests/dromaeo/cssquery-yui.html (next: http://localhost:44613/tests/dromaeo/cssquery-dojo.html) 09:41:37 INFO - PROCESS | 7686 | RSS: Main: 254558208 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | __start_tp_report 09:41:37 INFO - PROCESS | 7686 | _x_x_mozilla_page_load 09:41:37 INFO - PROCESS | 7686 | _x_x_mozilla_page_load_details 09:41:37 INFO - PROCESS | 7686 | |i|pagename|runs| 09:41:37 INFO - PROCESS | 7686 | |0;dojo.html;3251.6260630027546;3263.885763998259;3282.7702060855718;3316.9004929852113;3346.447836107042;5229.555487783538;5251.264822924793;5269.104252277112;5285.154375299952;5306.257124002638;5250.501202385777;5261.657992230512;5277.815276465324;5278.841634750954;5310.283111779909;4754.500777418373;4811.10994466024;4826.3001864729595;4864.5135486451245;4912.606991440676;4799.952000480003;4803.447603525605;4841.8305359312435;4850.296706977486;4916.70499770015;4803.663743537953;4841.467438581753;4862.367892174012;4880.3655524781725;4915.6313276504225;4868.683535570177;4869.853904382874;4883.609311255109;4889.902201955976;4890.608751299906;4683.227267500858;4803.159447096744;4832.323474713543;4847.636427267934;4919.704817710913;5185.455527169631;5195.1687729963405;5205.947940520584;5210.947890521084;5213.791448342062;5713.942860571383;5734.455226753452;5738.196652468658;5738.196652468658;5768.105943578752;5552.500274975271;5715.3141623005085;5819.53443724501;5843.386444423317;5857.384974577651;5294.629375943647;5297.311349524537;5299.947000529984;5301.602379821529;5304.283921670563;5692.459216374438;5751.281089863767;5754.74103665336;5754.798582049608;5798.710064496759;5432.266644003088;5433.0763770159165;5492.038893193675;5520.033994051025;5531.6957567333375;5675.404082571353;5684.147377893349;5685.630434021776;5688.630239034533;5689.487946084872;5541.722913854372;5657.490825825613;5658;5661.80183693577;5672.5745569081655;5691;5747.971260143672;5749.396313387034;5751.913721294184;5784.537237021028;4363.47638283408;4385.780710964503;4408.470983482002;4416.668749843775;4438.955610443919;3850;3922.5685174630767;3995.5005624296964;3997.2205419942834;4023.456833327522;5418.539424148991;5419.268398766195;5442.265294185234;5455.0453670607485;5472.890542189134;5770.538356931519;5789.8263052108505;5791.420857914175;5794.072948328248;5794.971025144847;5238.109521381374;5273.3935597406025;5340.145576707786;5418.539424148913;5436.972815135899;4960.677555958851;4979;4980.452150263468;4981.825636102792;4990;5952.166696662471;5972.134040564094;5974.970125149346;5975.223220981332;6008.909866352008;5510.421405752499;5708.172315014383;5734.569907256889;5756.280464941882;5810.360860305447;5947.3457919627945;5949.1076338549565;5955.970220148872;5968.164456976114;5981.401859813984;5685.971570142123;5696.829095127153;5697.7436015380235;5702.971485142548;5707.286589176353;5463.644863083887;5774.1916131740745;5838.708064596838;5843.912341314969;5869.970650146722;5464.726763661722;5500.202470641814;5514.200440936122;5514.476124768141;5543.556515478833;5445.7821687133655;5551.666899985852;5558.44415558441;5563.638363506521;5568.888622227451;5399.487048730364;5419.295491586068;5457.836264912059;5461.563074953915;5491.945080549143;5587.8882422352135;5592.7762889483965;5612.971935140298;5613.607047506635;5622.409646987171;5356.062689029326;5462.098753705594;5495.642783219078;5505.091659876076;5510.6969116698965 09:41:37 INFO - PROCESS | 7686 | |1;ext.html;537.2451705353978;553.382977979553;576.8010036537393;579.1428685545393;603.441816319904;32264.83867580662;39555.80222098889;40163;40226.99999999996;40254.597454025454;43958.90102747433;44602;44638;44651.77674111633;44670.77664611673;8057.274845263925;8209.343252539813;8846.646134154626;9072.682456114037;10340.741481462948;10491;10640;10658.840117398206;10662.093722033636;10665.680029599125;10624.46877656118;10725.463726813628;10732.892671073307;10735.946320268427;10739.731506712356;10527.631532896312;10604.151667866552;10622.362658240492;10622.840657390145;10629;10482;10602.946985265102;10616.734581635445;10625.468726563719;10909.34543927367;43323.35014974778;43730.562694372966;43765.56234437646;43797.12405751867;43820;3736.3461394255896;4240.321548552248;4477.48508921475;4521.3896124023495;4669.95330046702;32999.835000825085;33160;33337.49993750096;33493;33798.662013380046;4176.728512646669;4250.42619246404;4262.658987281041;4288.506821715511;4289.24938135825;280233;282012;283732;283786;283875;46686.06627867424;59794;59984;60011.399886001454;60103;44095.55904440978;44434.777826110665;44679;44703.55296446994;44743;15610.453634122978;16140.838591613934;16143.515694529184;16150.35398584067;16170.838291616934;11520.654380368602;12960.287184204959;13078.869211307765;13101.868981310256;13159.342032898508;15004.774928376082;15253.16107614092;15285.312160952784;15292.388304467697;15362.539123826304;5885.793997210077;5975.551833612496;6083.148359229712;6103.816885493442;6151.5386346024225;1062;1062.946852657364;1063.8989296016866;1080.4057768227601;1154.5554961339944;30604.234894127825;30811.8459407706;30909;30995.535066974015;31396.529052064237;1137.732632831284;1181.940902954866;1182;1223.9571614993433;1232.617888454582;15582.364641325896;15764.842351576566;16019.359225631077;16089.436869709503;16245.756313655305;333377;337348;338106;338290;338882;58147.70926145427;58181.709091455115;58410.12384814231;58466.707666462244;58589.41410585925;1243.7512497500536;1411.908225965309;1472.0725942655845;1483.6513419346445;1513.1299502785942;27661.446771064868;27676.723232767414;27904.16287511378;28257.293567660152;28520.85739571289;43649.78175109104;43892.341614875164;43937.34093988657;43938.78030609826;43989.34015989699;184533;186999;187719;187838;188285;29955.101346959626;33362.83318583488;34280.314393712484;35784.642153578134;38252;44522.55477445184;45095.77452112718;45163;45324.32013519734;46074.769626151654;36190.779425593064;37535.81232093822;37760.244795104496;38530.2293954125;38684.226315474094;36976.26047479089;37220;37545;37849.432258516696;38145;38354.232915342094;38544.61455385522;43716.56283437125;44754.77622611866;44821.32768008417;31671.683283166873;33497;33766.66233337635;34403;34427.82786086053;27735;27752.8612356945;28003;28321.858390708738;28344.43311133807 09:41:37 INFO - PROCESS | 7686 | |2;jquery.html;358.6843577651667;359.5577439749109;360.3567631777278;368.95203623528937;381.0644866851879;17674.29302827887;18248.087595620233;18296.45110646681;18585.721214181765;18619.255229790793;17960.281588736434;18205.271789128452;18800.529986750338;18821.811781882177;18823.24707011718;5547.77808887645;5623.915641265385;5637.238972738689;5668.829935101953;5697.6866272355;4289.6997210195295;5621.763212093333;5926.288845338566;6166.506679465654;6191.411815877507;6118.908216376758;6125.264968203822;6130.295016073142;6143.508519318466;6147.631142131464;5876.735546900379;6041.365656606037;6043.939560604382;6054.182685337467;6058.121572372003;3831.7509361891666;5104.795808167669;5295.682259064469;5321.148616221425;5321.8935621287355;20636.17455301786;21082.472938176514;21121.78878211229;21485.24801631951;21505.139794408205;2401.21960362881;2765.267204190891;2801.9352645994595;2805.1864959161817;2841.573763935426;13817.240051797147;14004.92997535016;14245.643858903506;14410.279486025656;14439.422423103064;1882.6611209982198;1907.2371051579341;1909.789923108457;1914.301280032778;1914.339552854263;63132.99999999954;63455.365446345866;63835.36164638387;64579;64616;9751.707448776548;9812.362196457207;10037;10047.447390393452;10135.9493202535;12719.364031798374;12839.550615728405;12840.486380544673;12853.421596028202;12861.164024338388;7816.804579885435;7923.286904178652;8023.117457079717;8037.799055023671;8110.837783244302;7790.5325680459355;7929.32600728933;7935.285824275843;7982.401319901031;8183.73152161416;6319.115323854664;6384.48924086072;6390.648514331757;6452.257990331078;6469.708863101077;1697.711389063862;1708.8547473464894;1722.1475369692082;1750.7636469076513;1779.1104447776113;1012.8075665623508;1026.771904966225;1067.199600299775;1127.2503784983057;1237.7524495101015;17876.28494860217;17983.280668773103;18086;18279.63440731178;18506.907465462587;1094.485591771866;1101.8126918423886;1113.504490501735;1149.1036991146918;1149.1611123879447;10712.732181695364;10768;10884.346939183675;10889.564417423373;10940.234183607072;429628;432547;435739;442798;445941;64180.67909660515;69808.30191698119;69963;70427.29572704309;71093.64453177805;1104.9944750276197;1118.8992990630882;1174.3834486894277;1180.6340034589305;1182.2079206931376;16320.67358652844;16365.672686545964;16454.341826326814;16504;16619;32827.835860820545;33640.1589960253;34506;34791.47812782861;35093.649063510056;45678.08643827171;45838.08323833571;46067;46313.53686463092;46398.53601464077;7959.363250939795;8087.231712987257;8091.109977902308;8225.054118776177;8423.326133909395;9105.863412048957;13222.735545288848;13344.733105338033;13668.52160174389;13692.041557090908;10843.620473283398;11002.449877506253;11190.94404527972;11281.943590281997;11600.30398176112;8676.349273804364;11349;11731.178817482694;11788.823167652321;11808.527658893549;11607.36159511235;11631.825522616999;11761.411929403666;11867.58463453775;11959.461824218106;7485.251474852689;7504.924950750423;7548.698052077855;7708.922910770821;8323.458975166595;11590.130740194687;11630.244034138092;11839.70400739954;11883;11942.701432464259 09:41:37 INFO - PROCESS | 7686 | |3;mootools.html;1485.4652325162947;1542.498687926424;1563.3824639267486;1748.9912550437245;1851.2132343753901;7857.1357150713375;8039.196080391958;8044.477108987919;8053.275205231528;8054.114047454776;7760.6119694015215;7882.881756773653;7885.842283154333;7886.29023387895;7890.644920978555;2043.38698390483;2076.283682129663;2338.8128949683983;2350.964735528964;2379.2267513058237;2436.987815060922;2443.584590619599;2446.3150317911013;2446.5351583199226;2448.963265551009;2326.8720220387872;2332.96500552491;2371.4190023444194;2385.522895420914;2388.0209114263157;2364.4443555764383;2402.303332033708;2405.074046492113;2406.302172370011;2418.7702168293986;2362;2362.267697013914;2385.856848589073;2386.940326491834;2407.590709579376;7956.2043795619975;7978.401619878474;7995.240452157036;8010.078840933309;8010.519368837889;5065.265536497187;5202.583793296527;5216.739163041832;5218.921716174261;5219.347581552306;3259.103746469716;3268.215628249227;3316.0217735768006;3321.086701157177;3362.36115138123;1051.1380667852363;1059.4808543813554;1080.2924084724518;1962.1268535501708;2091.4144039668918;10764.78470430587;10805.783884322269;10814.080803131743;10822.512986915608;10824.40465774382;4299.914001719948;4338.197433474817;4372.191144638188;4379.146066516999;4454.643628509712;9128.680496182602;9170.954145229365;9173.495457749888;9179.357444978921;9201.125893040151;4901.730404827768;4903.583195428358;4906.656534042583;4915.0415668944925;4919.631027672939;4076.2051399977313;4549.135664223853;4646.233371493733;4646.303054541778;4713.198756211452;3542.964570354315;3604.9098772530897;3637.217998130415;3690.5940346561856;3724.0875985383755;1111.4553868604487;1121.7588218532892;1126.9549218031186;1127.1658972360394;1130.429133287701;1410.541573988458;1442.3869855311661;1458.3364569121024;1476.9852301477063;1518.483715536723;7658.923410765821;7661.961690191513;7707.421943354271;7716.6527506262355;7722.3049925506975;517.3507248403305;518.9429162792089;528.2498851630694;533.9626226164131;539.2989114151587;5857.7656893724625;5858.8242352729485;5860.531157507389;5881.911771323434;5936;9043.095690431035;9293.349465537347;9294.302927280482;9412.67055653049;9417.529123543933;9666.033396660418;9668.516574171263;9859.704208873745;9883.50582470888;9895.901040989498;7640.503367281221;7782.066152061789;7801.765947021599;7861.646225919847;7869.724559640385;7518.736844210426;7558.168601453725;7615.390768738598;7664.8850267244925;7688.077430708351;8884.289256859307;8948.373613847229;8971.461712297283;9053.2304754094;9138.771530711785;8982.146696063863;9333.439993600407;9333.48665823359;9337.71986840396;9404.247660187031;6229.5327850410495;6321.273053598895;6734.393904548614;7170.892436613351;7255.09311336083;7524.360429363565;7530;7530.510516816608;7536.5101268417375;7570.659320330708;6810.31896810315;7037.507374483737;7097.183823860322;7140.607266600179;7218.386437152901;6983.476239281973;6984.161900571964;7042.366187043191;7055.153381594241;7105.928940710527;7016.087908571853;7032.929670703227;7153.070100886852;7168.928310717035;7171.1753148386515;6611.966940165461;6637.203535575762;6647.833804154935;6660.333966603301;6664.500162487736;6574.704138313692;6593.703283352356;6616.636085015371;6775.864482710417;6933.618650974245 09:41:37 INFO - PROCESS | 7686 | |4;prototype.html;338.7730220752096;342.10710046777905;343.62029956897635;360.4881068882187;367.67093451361035;6095.75616975321;6124.9693751531295;6126.724297406617;6127.2034635497375;6154.876902461948;6049.606775559597;6053.606515576495;6062.969685151579;6075.726592303346;6079.63522188669;4465.9330110048295;4568.406107206059;4568.931466028012;4573.542645735433;4576.633869290466;4645.674802763808;4655.4180727409075;4680.368150299717;4688.9765551172195;4691.4604820445575;4669.042846216535;4670.346151538787;4670.579647831694;4671.065786842645;4677.228257337535;4509;4512.390827238313;4597.3793537872625;4628.375169352162;4680.953190468103;4027.033511957109;4029.597040295976;4029.8992525186814;4047.655949244318;4055.634992850628;5767.740451679684;5785.884282314372;5791.536677065825;5797.913031304533;5799.88400231993;5368.677879327252;5368.865778355534;5371.838844834661;5373.785048598091;5392.811251606214;6435.485161187094;6441.162648855666;6443.871122577569;6445.742170313229;6452.419282264619;4362.8691139265875;4487.865364039084;4493.887652808706;4529.86410407685;4535.750533720644;6725.327467253284;6752.493562982747;6775.898361524581;6779.932200677979;6786.72853085876;4557.840475583339;4570.223062079454;4573.588377046081;4577.1074640444795;4578.244589642672;4636.072785442858;4638.281066434708;4639.582437580567;4640.211164102111;4640.605548528345;5368.1679339702405;5368.5436737876935;5371.4897084776885;5375.139977603565;5377.892442151135;6332.620042797447;6521.119648847345;6523.575967562093;6531.183602049744;6558.114654521674;1587.547548948544;1590.332060534555;1592.4028489316506;1598.352667169798;1601.54356008537;1046.8482070099792;1056.8573242612304;1080.6649938519083;1084.6420681175193;1094.3816743539874;6077.058056001327;6195.411435913581;6302.1177035215105;6331.556791024676;6341.936580634135;6748.426383757337;6763.695633696496;6771.322867713189;6776.525643204928;6780.423663988518;6314.71583778731;6323.470611755335;6325.114483972247;6326.746930122744;6326.968365158237;3624.7462677612316;3653.5067765851268;3655.305491956573;3657.0674478007936;3658.7438879278193;6858.245592984767;6978.755743548952;7001.404880585105;7006.124234470692;7010.75462358815;6867.175938887265;6888.758893438706;6894.448444124458;6898.0687607173395;6898.482613803984;6941.097657304518;6964.094667693167;6971.431427928777;6973.919042548312;6977;6725.730970761115;6736.360045795642;6738.6967586459705;6741.865162696817;6746.089277947414;6486.902696459462;6641.734330626721;6646.501512386493;6647.434968027772;6663.600183988976;6967.547109438073;6984.650767461708;6985.26654701249;6998.54509456904;6999.1950925644205;4460.130274596422;4460.1971645104195;4461.375407443025;4469.329600559942;4471.61991230749;6739.191297044386;6739.831504212434;6743.52795304324;6756.797296081126;6825.624590647562;6399.520035997412;6521.152250207443;6543.378379053982;6556.2788093310655;6556.541042127196;6512.446442052478;6556.737730490918;6558.311377305315;6567.671616419256;6568.211814582281;6453.677316134268;6461.418472337512;6462.386073323027;6464.997925321582;6466.579672321284;6589.077529145828;6596.8350791230605;6606.174228221473;6608.900866486911;6609.339066093352;6161.784337548164;6299.244090709144;6447.194100737408;6455.644939528371;6459.838504037437 09:41:37 INFO - PROCESS | 7686 | |5;yui.html;761.6458346868704;778.4978688745763;857.8713193021047;895.0646574329825;954.8376775948091;13551.25468099254;14762.63093422665;14886.478973235939;14907.478238261663;14932.253387330644;12023.098267629919;12125.939370303158;12126.878731212708;12129.150959432844;12130;764.8240904591947;903.6520939438298;921.0421161991537;921.6405601815297;936.7892224249557;932.9113734195274;936.4755736787387;941.23759754599;941.4774799986005;941.6939494664227;986.2159583131428;989.5497548615363;994.7015895231438;995.5818556206375;995.9502024898726;801.6552882260626;980.9313348065639;981.175812317653;994.7960668063103;995.8356871116257;736.8710475666737;737.797105795905;737.8634952533798;737.9077615298088;739.6338812287898;13586.728265434735;13623.659408514768;13634.181949082988;13634.318284085755;13641.454341826315;14422.134671919719;14497.927510362486;14516;14549.054311469721;14568.927155364261;11098.167637427145;11278.097752179807;11354.545818167264;11493.195476316578;11556.1332900032;3898.4542164097047;3928.4696565963513;3992.261431635128;4005.61946615074;4034.5763694811917;50717.746411267704;51078.489215108115;51116;51389;51482.742586286826;10341.586336546605;10708.1433485321;10837.729056773644;10868.45657717111;10911.83632245517;19346.613067738846;19517;19527.218911243675;19528;19538.12078456473;8282.585870706562;8311;8449.788755281168;8457;8529.530875801891;4730.408698912636;4802.087603355351;4815.22956326986;4849.175640141185;4883.145449546315;3252.70725634694;3263.592050993626;3272.640009598942;3274.590676165479;3277.2789986203475;613.9416755408229;625.7371903800415;627.6547898655721;629.3077614623877;630.095812509051;720.945929055323;746.4625469661943;752.3379426104992;782.776908581063;782.945193836426;8520.403571750043;8728.127187281221;8744.956275218583;8902.599383027778;8904.821903562022;602.9638221706712;615.7290792051483;714.5530301140129;728.602911413281;748.6930358552967;4093.85671501496;4261.190373828963;4379.430674012358;4397.8240870364825;4415.40392047076;57335.13997290044;58371.12443313269;58383.4161658378;60154;61236.08145877816;51939.74030129901;52474;52824.47175528272;52848.67878303073;53344.73327633337;47523;47703.76148119307;47875.76062119667;47992.520074798806;48074.759626201645;9310.95344523273;9329.72010839676;9363.344565880323;9474.194693451134;9506.572204250688;35386.646133538336;35434.29131417305;36032.27935441329;36226.27547449089;36794.448083278236;43782.781086094365;44665.10669786651;44687;45597.31604025876;45947.31079033884;11902.880971190178;12148.574799881962;12166;12209.511619535118;12467.75064498723;11573.537058517564;12578.245305281713;12832.486700532249;13033.543825966046;13418.932905335801;12286.754264914473;12333.198342107735;12388.876111238773;12494.812577811159;12577.685557861127;11632.476538555617;11670.591529296435;11741.530338786353;11802.468888899848;11875.16873818859;12120.151589388659;12222.755544888874;12303.876961230273;12441.813372799596;12686.619401417973;10156.949215253877;10234.437105959243;10535.947320263349;10563.260571760211;10740.248182627141;10156.39061656303;10536.15710743154;10549.73625659334;10582.365058096539;10586.735331616772 09:41:37 INFO - PROCESS | 7686 | __end_tp_report 09:41:37 INFO - PROCESS | 7686 | __start_cc_report 09:41:37 INFO - PROCESS | 7686 | _x_x_mozilla_cycle_collect,790 09:41:37 INFO - PROCESS | 7686 | __end_cc_report 09:41:37 INFO - PROCESS | 7686 | __startTimestamp1458146497625__endTimestamp 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | ------- Summary: start ------- 09:41:37 INFO - PROCESS | 7686 | Number of tests: 6 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | [#0] dojo.html Cycles:165 Average:5301.20 Median:5462.10 stddev:576.29 (10.6%) stddev-sans-first:555.17 09:41:37 INFO - PROCESS | 7686 | Values: 3251.6 3263.9 3282.8 3316.9 3346.4 5229.6 5251.3 5269.1 5285.2 5306.3 5250.5 5261.7 5277.8 5278.8 5310.3 4754.5 4811.1 4826.3 4864.5 4912.6 4800.0 4803.4 4841.8 4850.3 4916.7 4803.7 4841.5 4862.4 4880.4 4915.6 4868.7 4869.9 4883.6 4889.9 4890.6 4683.2 4803.2 4832.3 4847.6 4919.7 5185.5 5195.2 5205.9 5210.9 5213.8 5713.9 5734.5 5738.2 5738.2 5768.1 5552.5 5715.3 5819.5 5843.4 5857.4 5294.6 5297.3 5299.9 5301.6 5304.3 5692.5 5751.3 5754.7 5754.8 5798.7 5432.3 5433.1 5492.0 5520.0 5531.7 5675.4 5684.1 5685.6 5688.6 5689.5 5541.7 5657.5 5658.0 5661.8 5672.6 5691.0 5748.0 5749.4 5751.9 5784.5 4363.5 4385.8 4408.5 4416.7 4439.0 3850.0 3922.6 3995.5 3997.2 4023.5 5418.5 5419.3 5442.3 5455.0 5472.9 5770.5 5789.8 5791.4 5794.1 5795.0 5238.1 5273.4 5340.1 5418.5 5437.0 4960.7 4979.0 4980.5 4981.8 4990.0 5952.2 5972.1 5975.0 5975.2 6008.9 5510.4 5708.2 5734.6 5756.3 5810.4 5947.3 5949.1 5956.0 5968.2 5981.4 5686.0 5696.8 5697.7 5703.0 5707.3 5463.6 5774.2 5838.7 5843.9 5870.0 5464.7 5500.2 5514.2 5514.5 5543.6 5445.8 5551.7 5558.4 5563.6 5568.9 5399.5 5419.3 5457.8 5461.6 5491.9 5587.9 5592.8 5613.0 5613.6 5622.4 5356.1 5462.1 5495.6 5505.1 5510.7 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | [#1] ext.html Cycles:180 Average:44970.12 Median:185422.50 stddev:72075.96 (38.9%) stddev-sans-first:72200.94 09:41:37 INFO - PROCESS | 7686 | Values: 537.2 553.4 576.8 579.1 603.4 32264.8 39555.8 40163.0 40227.0 40254.6 43958.9 44602.0 44638.0 44651.8 44670.8 8057.3 8209.3 8846.6 9072.7 10340.7 10491.0 10640.0 10658.8 10662.1 10665.7 10624.5 10725.5 10732.9 10735.9 10739.7 10527.6 10604.2 10622.4 10622.8 10629.0 10482.0 10602.9 10616.7 10625.5 10909.3 43323.4 43730.6 43765.6 43797.1 43820.0 3736.3 4240.3 4477.5 4521.4 4670.0 32999.8 33160.0 33337.5 33493.0 33798.7 4176.7 4250.4 4262.7 4288.5 4289.2 280233.0 282012.0 283732.0 283786.0 283875.0 46686.1 59794.0 59984.0 60011.4 60103.0 44095.6 44434.8 44679.0 44703.6 44743.0 15610.5 16140.8 16143.5 16150.4 16170.8 11520.7 12960.3 13078.9 13101.9 13159.3 15004.8 15253.2 15285.3 15292.4 15362.5 5885.8 5975.6 6083.1 6103.8 6151.5 1062.0 1062.9 1063.9 1080.4 1154.6 30604.2 30811.8 30909.0 30995.5 31396.5 1137.7 1181.9 1182.0 1224.0 1232.6 15582.4 15764.8 16019.4 16089.4 16245.8 333377.0 337348.0 338106.0 338290.0 338882.0 58147.7 58181.7 58410.1 58466.7 58589.4 1243.8 1411.9 1472.1 1483.7 1513.1 27661.4 27676.7 27904.2 28257.3 28520.9 43649.8 43892.3 43937.3 43938.8 43989.3 184533.0 186999.0 187719.0 187838.0 188285.0 29955.1 33362.8 34280.3 35784.6 38252.0 44522.6 45095.8 45163.0 45324.3 46074.8 36190.8 37535.8 37760.2 38530.2 38684.2 36976.3 37220.0 37545.0 37849.4 38145.0 38354.2 38544.6 43716.6 44754.8 44821.3 31671.7 33497.0 33766.7 34403.0 34427.8 27735.0 27752.9 28003.0 28321.9 28344.4 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | [#2] jquery.html Cycles:180 Average:25724.20 Median:11953.18 stddev:71516.29 (598.3%) stddev-sans-first:71691.55 09:41:37 INFO - PROCESS | 7686 | Values: 358.7 359.6 360.4 369.0 381.1 17674.3 18248.1 18296.5 18585.7 18619.3 17960.3 18205.3 18800.5 18821.8 18823.2 5547.8 5623.9 5637.2 5668.8 5697.7 4289.7 5621.8 5926.3 6166.5 6191.4 6118.9 6125.3 6130.3 6143.5 6147.6 5876.7 6041.4 6043.9 6054.2 6058.1 3831.8 5104.8 5295.7 5321.1 5321.9 20636.2 21082.5 21121.8 21485.2 21505.1 2401.2 2765.3 2801.9 2805.2 2841.6 13817.2 14004.9 14245.6 14410.3 14439.4 1882.7 1907.2 1909.8 1914.3 1914.3 63133.0 63455.4 63835.4 64579.0 64616.0 9751.7 9812.4 10037.0 10047.4 10135.9 12719.4 12839.6 12840.5 12853.4 12861.2 7816.8 7923.3 8023.1 8037.8 8110.8 7790.5 7929.3 7935.3 7982.4 8183.7 6319.1 6384.5 6390.6 6452.3 6469.7 1697.7 1708.9 1722.1 1750.8 1779.1 1012.8 1026.8 1067.2 1127.3 1237.8 17876.3 17983.3 18086.0 18279.6 18506.9 1094.5 1101.8 1113.5 1149.1 1149.2 10712.7 10768.0 10884.3 10889.6 10940.2 429628.0 432547.0 435739.0 442798.0 445941.0 64180.7 69808.3 69963.0 70427.3 71093.6 1105.0 1118.9 1174.4 1180.6 1182.2 16320.7 16365.7 16454.3 16504.0 16619.0 32827.8 33640.2 34506.0 34791.5 35093.6 45678.1 45838.1 46067.0 46313.5 46398.5 7959.4 8087.2 8091.1 8225.1 8423.3 9105.9 13222.7 13344.7 13668.5 13692.0 10843.6 11002.4 11190.9 11281.9 11600.3 8676.3 11349.0 11731.2 11788.8 11808.5 11607.4 11631.8 11761.4 11867.6 11959.5 7485.3 7504.9 7548.7 7708.9 8323.5 11590.1 11630.2 11839.7 11883.0 11942.7 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | [#3] mootools.html Cycles:180 Average:5637.77 Median:6275.40 stddev:2900.20 (46.2%) stddev-sans-first:2891.54 09:41:37 INFO - PROCESS | 7686 | Values: 1485.5 1542.5 1563.4 1749.0 1851.2 7857.1 8039.2 8044.5 8053.3 8054.1 7760.6 7882.9 7885.8 7886.3 7890.6 2043.4 2076.3 2338.8 2351.0 2379.2 2437.0 2443.6 2446.3 2446.5 2449.0 2326.9 2333.0 2371.4 2385.5 2388.0 2364.4 2402.3 2405.1 2406.3 2418.8 2362.0 2362.3 2385.9 2386.9 2407.6 7956.2 7978.4 7995.2 8010.1 8010.5 5065.3 5202.6 5216.7 5218.9 5219.3 3259.1 3268.2 3316.0 3321.1 3362.4 1051.1 1059.5 1080.3 1962.1 2091.4 10764.8 10805.8 10814.1 10822.5 10824.4 4299.9 4338.2 4372.2 4379.1 4454.6 9128.7 9171.0 9173.5 9179.4 9201.1 4901.7 4903.6 4906.7 4915.0 4919.6 4076.2 4549.1 4646.2 4646.3 4713.2 3543.0 3604.9 3637.2 3690.6 3724.1 1111.5 1121.8 1127.0 1127.2 1130.4 1410.5 1442.4 1458.3 1477.0 1518.5 7658.9 7662.0 7707.4 7716.7 7722.3 517.4 518.9 528.2 534.0 539.3 5857.8 5858.8 5860.5 5881.9 5936.0 9043.1 9293.3 9294.3 9412.7 9417.5 9666.0 9668.5 9859.7 9883.5 9895.9 7640.5 7782.1 7801.8 7861.6 7869.7 7518.7 7558.2 7615.4 7664.9 7688.1 8884.3 8948.4 8971.5 9053.2 9138.8 8982.1 9333.4 9333.5 9337.7 9404.2 6229.5 6321.3 6734.4 7170.9 7255.1 7524.4 7530.0 7530.5 7536.5 7570.7 6810.3 7037.5 7097.2 7140.6 7218.4 6983.5 6984.2 7042.4 7055.2 7105.9 7016.1 7032.9 7153.1 7168.9 7171.2 6612.0 6637.2 6647.8 6660.3 6664.5 6574.7 6593.7 6616.6 6775.9 6933.6 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | [#4] prototype.html Cycles:180 Average:5431.57 Median:6158.33 stddev:1659.93 (27.0%) stddev-sans-first:1619.98 09:41:37 INFO - PROCESS | 7686 | Values: 338.8 342.1 343.6 360.5 367.7 6095.8 6125.0 6126.7 6127.2 6154.9 6049.6 6053.6 6063.0 6075.7 6079.6 4465.9 4568.4 4568.9 4573.5 4576.6 4645.7 4655.4 4680.4 4689.0 4691.5 4669.0 4670.3 4670.6 4671.1 4677.2 4509.0 4512.4 4597.4 4628.4 4681.0 4027.0 4029.6 4029.9 4047.7 4055.6 5767.7 5785.9 5791.5 5797.9 5799.9 5368.7 5368.9 5371.8 5373.8 5392.8 6435.5 6441.2 6443.9 6445.7 6452.4 4362.9 4487.9 4493.9 4529.9 4535.8 6725.3 6752.5 6775.9 6779.9 6786.7 4557.8 4570.2 4573.6 4577.1 4578.2 4636.1 4638.3 4639.6 4640.2 4640.6 5368.2 5368.5 5371.5 5375.1 5377.9 6332.6 6521.1 6523.6 6531.2 6558.1 1587.5 1590.3 1592.4 1598.4 1601.5 1046.8 1056.9 1080.7 1084.6 1094.4 6077.1 6195.4 6302.1 6331.6 6341.9 6748.4 6763.7 6771.3 6776.5 6780.4 6314.7 6323.5 6325.1 6326.7 6327.0 3624.7 3653.5 3655.3 3657.1 3658.7 6858.2 6978.8 7001.4 7006.1 7010.8 6867.2 6888.8 6894.4 6898.1 6898.5 6941.1 6964.1 6971.4 6973.9 6977.0 6725.7 6736.4 6738.7 6741.9 6746.1 6486.9 6641.7 6646.5 6647.4 6663.6 6967.5 6984.7 6985.3 6998.5 6999.2 4460.1 4460.2 4461.4 4469.3 4471.6 6739.2 6739.8 6743.5 6756.8 6825.6 6399.5 6521.2 6543.4 6556.3 6556.5 6512.4 6556.7 6558.3 6567.7 6568.2 6453.7 6461.4 6462.4 6465.0 6466.6 6589.1 6596.8 6606.2 6608.9 6609.3 6161.8 6299.2 6447.2 6455.6 6459.8 09:41:37 INFO - PROCESS | 7686 | 09:41:37 INFO - PROCESS | 7686 | [#5] yui.html Cycles:180 Average:14466.04 Median:24540.26 stddev:16393.14 (66.8%) stddev-sans-first:16406.82 09:41:37 INFO - PROCESS | 7686 | Values: 761.6 778.5 857.9 895.1 954.8 13551.3 14762.6 14886.5 14907.5 14932.3 12023.1 12125.9 12126.9 12129.2 12130.0 764.8 903.7 921.0 921.6 936.8 932.9 936.5 941.2 941.5 941.7 986.2 989.5 994.7 995.6 996.0 801.7 980.9 981.2 994.8 995.8 736.9 737.8 737.9 737.9 739.6 13586.7 13623.7 13634.2 13634.3 13641.5 14422.1 14497.9 14516.0 14549.1 14568.9 11098.2 11278.1 11354.5 11493.2 11556.1 3898.5 3928.5 3992.3 4005.6 4034.6 50717.7 51078.5 51116.0 51389.0 51482.7 10341.6 10708.1 10837.7 10868.5 10911.8 19346.6 19517.0 19527.2 19528.0 19538.1 8282.6 8311.0 8449.8 8457.0 8529.5 4730.4 4802.1 4815.2 4849.2 4883.1 3252.7 3263.6 3272.6 3274.6 3277.3 613.9 625.7 627.7 629.3 630.1 720.9 746.5 752.3 782.8 782.9 8520.4 8728.1 8745.0 8902.6 8904.8 603.0 615.7 714.6 728.6 748.7 4093.9 4261.2 4379.4 4397.8 4415.4 57335.1 58371.1 58383.4 60154.0 61236.1 51939.7 52474.0 52824.5 52848.7 53344.7 47523.0 47703.8 47875.8 47992.5 48074.8 9311.0 9329.7 9363.3 9474.2 9506.6 35386.6 35434.3 36032.3 36226.3 36794.4 43782.8 44665.1 44687.0 45597.3 45947.3 11902.9 12148.6 12166.0 12209.5 12467.8 11573.5 12578.2 12832.5 13033.5 13418.9 12286.8 12333.2 12388.9 12494.8 12577.7 11632.5 11670.6 11741.5 11802.5 11875.2 12120.2 12222.8 12303.9 12441.8 12686.6 10156.9 10234.4 10535.9 10563.3 10740.2 10156.4 10536.2 10549.7 10582.4 10586.7 09:41:37 INFO - PROCESS | 7686 | -------- Summary: end -------- 09:41:37 INFO - PROCESS | 7686 | 09:41:38 INFO - TEST-INFO | 7686: exit 0 09:41:38 INFO - TEST-OK | dromaeo_css | took 1110522ms 09:41:38 INFO - TEST-START | kraken 09:41:38 INFO - operating with platform_type : linux_ 09:41:38 INFO - Initialising browser for kraken test... 09:41:38 INFO - TEST-INFO | started process 7880 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMFBfhp/profile http://localhost:44613/getInfo.html) 09:41:42 INFO - PROCESS | 7880 | __metrics Screen width/height:1600/1200 09:41:42 INFO - PROCESS | 7880 | colorDepth:24 09:41:42 INFO - PROCESS | 7880 | Browser inner width/height: 1024/697 09:41:42 INFO - PROCESS | 7880 | __metrics 09:41:43 INFO - PROCESS | 7880 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:44 INFO - TEST-INFO | 7880: exit 0 09:41:44 INFO - Browser initialized. 09:41:44 INFO - Running cycle 1/1 for kraken test... 09:41:44 INFO - TEST-INFO | started process 7968 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMFBfhp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:55 INFO - PROCESS | 7968 | RSS: Main: 144850944 09:41:55 INFO - PROCESS | 7968 | 09:41:58 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44613/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:58 INFO - PROCESS | 7968 | RSS: Main: 181342208 09:41:58 INFO - PROCESS | 7968 | 09:42:01 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44613/tests/kraken/driver.html?testName=audio-dft) 09:42:02 INFO - PROCESS | 7968 | RSS: Main: 177668096 09:42:02 INFO - PROCESS | 7968 | 09:42:04 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44613/tests/kraken/driver.html?testName=audio-fft) 09:42:05 INFO - PROCESS | 7968 | RSS: Main: 176119808 09:42:05 INFO - PROCESS | 7968 | 09:42:07 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44613/tests/kraken/driver.html?testName=audio-oscillator) 09:42:08 INFO - PROCESS | 7968 | RSS: Main: 177147904 09:42:08 INFO - PROCESS | 7968 | 09:42:10 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:10 INFO - PROCESS | 7968 | RSS: Main: 173076480 09:42:10 INFO - PROCESS | 7968 | 09:42:13 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44613/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:14 INFO - PROCESS | 7968 | RSS: Main: 174116864 09:42:14 INFO - PROCESS | 7968 | 09:42:17 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44613/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:18 INFO - PROCESS | 7968 | RSS: Main: 172826624 09:42:18 INFO - PROCESS | 7968 | 09:42:21 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44613/tests/kraken/driver.html?testName=json-parse-financial) 09:42:21 INFO - PROCESS | 7968 | RSS: Main: 173756416 09:42:21 INFO - PROCESS | 7968 | 09:42:23 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:23 INFO - PROCESS | 7968 | RSS: Main: 179073024 09:42:23 INFO - PROCESS | 7968 | 09:42:25 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:26 INFO - PROCESS | 7968 | RSS: Main: 175321088 09:42:26 INFO - PROCESS | 7968 | 09:42:28 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:28 INFO - PROCESS | 7968 | RSS: Main: 181788672 09:42:28 INFO - PROCESS | 7968 | 09:42:31 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:31 INFO - PROCESS | 7968 | RSS: Main: 189681664 09:42:31 INFO - PROCESS | 7968 | 09:42:34 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:34 INFO - PROCESS | 7968 | RSS: Main: 189927424 09:42:34 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | Cycle 1(1): loaded http://localhost:44613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44613/tests/kraken/driver.html?testName=ai-astar) 09:42:36 INFO - PROCESS | 7968 | RSS: Main: 249663488 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | __start_tp_report 09:42:36 INFO - PROCESS | 7968 | _x_x_mozilla_page_load 09:42:36 INFO - PROCESS | 7968 | _x_x_mozilla_page_load_details 09:42:36 INFO - PROCESS | 7968 | |i|pagename|runs| 09:42:36 INFO - PROCESS | 7968 | |0;ai-astar;111;113;108;113;113;112;99;111;112;112 09:42:36 INFO - PROCESS | 7968 | |1;audio-beat-detection;151;125;153;171;126;153;153;139;180;127 09:42:36 INFO - PROCESS | 7968 | |2;audio-dft;162;160;161;161;159;160;161;163;161;161 09:42:36 INFO - PROCESS | 7968 | |3;audio-fft;75;75;75;180;73;71;75;72;164;75 09:42:36 INFO - PROCESS | 7968 | |4;audio-oscillator;93;93;146;92;94;93;140;92;93;147 09:42:36 INFO - PROCESS | 7968 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 09:42:36 INFO - PROCESS | 7968 | |6;imaging-darkroom;147;146;147;145;145;145;146;147;146;146 09:42:36 INFO - PROCESS | 7968 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;96 09:42:36 INFO - PROCESS | 7968 | |8;json-parse-financial;53;57;56;56;55;56;58;64;55;53 09:42:36 INFO - PROCESS | 7968 | |9;json-stringify-tinderbox;64;64;64;65;64;65;65;64;64;65 09:42:36 INFO - PROCESS | 7968 | |10;stanford-crypto-aes;76;76;77;78;79;88;78;78;86;79 09:42:36 INFO - PROCESS | 7968 | |11;stanford-crypto-ccm;110;110;117;112;111;116;115;111;110;113 09:42:36 INFO - PROCESS | 7968 | |12;stanford-crypto-pbkdf2;144;156;140;139;139;137;140;151;144;149 09:42:36 INFO - PROCESS | 7968 | |13;stanford-crypto-sha256-iterative;67;67;68;67;69;64;66;69;64;65 09:42:36 INFO - PROCESS | 7968 | __end_tp_report 09:42:36 INFO - PROCESS | 7968 | __start_cc_report 09:42:36 INFO - PROCESS | 7968 | _x_x_mozilla_cycle_collect,1045 09:42:36 INFO - PROCESS | 7968 | __end_cc_report 09:42:36 INFO - PROCESS | 7968 | __startTimestamp1458146556739__endTimestamp 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | ------- Summary: start ------- 09:42:36 INFO - PROCESS | 7968 | Number of tests: 14 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.50 stddev:4.27 (3.8%) stddev-sans-first:4.53 09:42:36 INFO - PROCESS | 7968 | Values: 111.0 113.0 108.0 113.0 113.0 112.0 99.0 111.0 112.0 112.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.00 stddev:18.77 (12.3%) stddev-sans-first:19.88 09:42:36 INFO - PROCESS | 7968 | Values: 151.0 125.0 153.0 171.0 126.0 153.0 153.0 139.0 180.0 127.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 09:42:36 INFO - PROCESS | 7968 | Values: 162.0 160.0 161.0 161.0 159.0 160.0 161.0 163.0 161.0 161.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:41.57 (55.4%) stddev-sans-first:43.55 09:42:36 INFO - PROCESS | 7968 | Values: 75.0 75.0 75.0 180.0 73.0 71.0 75.0 72.0 164.0 75.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.94 (26.8%) stddev-sans-first:25.83 09:42:36 INFO - PROCESS | 7968 | Values: 93.0 93.0 146.0 92.0 94.0 93.0 140.0 92.0 93.0 147.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:42:36 INFO - PROCESS | 7968 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 09:42:36 INFO - PROCESS | 7968 | Values: 147.0 146.0 147.0 145.0 145.0 145.0 146.0 147.0 146.0 146.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:42:36 INFO - PROCESS | 7968 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.13 (5.6%) stddev-sans-first:3.08 09:42:36 INFO - PROCESS | 7968 | Values: 53.0 57.0 56.0 56.0 55.0 56.0 58.0 64.0 55.0 53.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:42:36 INFO - PROCESS | 7968 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.50 stddev:4.12 (5.2%) stddev-sans-first:4.17 09:42:36 INFO - PROCESS | 7968 | Values: 76.0 76.0 77.0 78.0 79.0 88.0 78.0 78.0 86.0 79.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#11] stanford-crypto-ccm Cycles:10 Average:112.50 Median:112.50 stddev:2.64 (2.3%) stddev-sans-first:2.64 09:42:36 INFO - PROCESS | 7968 | Values: 110.0 110.0 117.0 112.0 111.0 116.0 115.0 111.0 110.0 113.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:144.00 stddev:6.23 (4.3%) stddev-sans-first:6.60 09:42:36 INFO - PROCESS | 7968 | Values: 144.0 156.0 140.0 139.0 139.0 137.0 140.0 151.0 144.0 149.0 09:42:36 INFO - PROCESS | 7968 | 09:42:36 INFO - PROCESS | 7968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 09:42:36 INFO - PROCESS | 7968 | Values: 67.0 67.0 68.0 67.0 69.0 64.0 66.0 69.0 64.0 65.0 09:42:36 INFO - PROCESS | 7968 | -------- Summary: end -------- 09:42:36 INFO - PROCESS | 7968 | 09:42:37 INFO - TEST-INFO | 7968: exit 0 09:42:37 INFO - TEST-OK | kraken | took 59301ms 09:42:37 INFO - SUITE-END | took 1169s 09:42:37 INFO - Completed test suite (00:19:30) 09:42:37 INFO - javascript benchmark 09:42:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3251.6260630027546, 3263.885763998259, 3282.7702060855718, 3316.9004929852113, 3346.447836107042, 5229.555487783538, 5251.264822924793, 5269.104252277112, 5285.154375299952, 5306.257124002638, 5250.501202385777, 5261.657992230512, 5277.815276465324, 5278.841634750954, 5310.283111779909, 4754.500777418373, 4811.10994466024, 4826.3001864729595, 4864.5135486451245, 4912.606991440676, 4799.952000480003, 4803.447603525605, 4841.8305359312435, 4850.296706977486, 4916.70499770015, 4803.663743537953, 4841.467438581753, 4862.367892174012, 4880.3655524781725, 4915.6313276504225, 4868.683535570177, 4869.853904382874, 4883.609311255109, 4889.902201955976, 4890.608751299906, 4683.227267500858, 4803.159447096744, 4832.323474713543, 4847.636427267934, 4919.704817710913, 5185.455527169631, 5195.1687729963405, 5205.947940520584, 5210.947890521084, 5213.791448342062, 5713.942860571383, 5734.455226753452, 5738.196652468658, 5738.196652468658, 5768.105943578752, 5552.500274975271, 5715.3141623005085, 5819.53443724501, 5843.386444423317, 5857.384974577651, 5294.629375943647, 5297.311349524537, 5299.947000529984, 5301.602379821529, 5304.283921670563, 5692.459216374438, 5751.281089863767, 5754.74103665336, 5754.798582049608, 5798.710064496759, 5432.266644003088, 5433.0763770159165, 5492.038893193675, 5520.033994051025, 5531.6957567333375, 5675.404082571353, 5684.147377893349, 5685.630434021776, 5688.630239034533, 5689.487946084872, 5541.722913854372, 5657.490825825613, 5658.0, 5661.80183693577, 5672.5745569081655, 5691.0, 5747.971260143672, 5749.396313387034, 5751.913721294184, 5784.537237021028, 4363.47638283408, 4385.780710964503, 4408.470983482002, 4416.668749843775, 4438.955610443919, 3850.0, 3922.5685174630767, 3995.5005624296964, 3997.2205419942834, 4023.456833327522, 5418.539424148991, 5419.268398766195, 5442.265294185234, 5455.0453670607485, 5472.890542189134, 5770.538356931519, 5789.8263052108505, 5791.420857914175, 5794.072948328248, 5794.971025144847, 5238.109521381374, 5273.3935597406025, 5340.145576707786, 5418.539424148913, 5436.972815135899, 4960.677555958851, 4979.0, 4980.452150263468, 4981.825636102792, 4990.0, 5952.166696662471, 5972.134040564094, 5974.970125149346, 5975.223220981332, 6008.909866352008, 5510.421405752499, 5708.172315014383, 5734.569907256889, 5756.280464941882, 5810.360860305447, 5947.3457919627945, 5949.1076338549565, 5955.970220148872, 5968.164456976114, 5981.401859813984, 5685.971570142123, 5696.829095127153, 5697.7436015380235, 5702.971485142548, 5707.286589176353, 5463.644863083887, 5774.1916131740745, 5838.708064596838, 5843.912341314969, 5869.970650146722, 5464.726763661722, 5500.202470641814, 5514.200440936122, 5514.476124768141, 5543.556515478833, 5445.7821687133655, 5551.666899985852, 5558.44415558441, 5563.638363506521, 5568.888622227451, 5399.487048730364, 5419.295491586068, 5457.836264912059, 5461.563074953915, 5491.945080549143, 5587.8882422352135, 5592.7762889483965, 5612.971935140298, 5613.607047506635, 5622.409646987171, 5356.062689029326, 5462.098753705594, 5495.642783219078, 5505.091659876076, 5510.6969116698965], "unit": "score", "name": "dojo.html", "value": 5265.244968441063}, {"lowerIsBetter": false, "replicates": [537.2451705353978, 553.382977979553, 576.8010036537393, 579.1428685545393, 603.441816319904, 32264.83867580662, 39555.80222098889, 40163.0, 40226.99999999996, 40254.597454025454, 43958.90102747433, 44602.0, 44638.0, 44651.77674111633, 44670.77664611673, 8057.274845263925, 8209.343252539813, 8846.646134154626, 9072.682456114037, 10340.741481462948, 10491.0, 10640.0, 10658.840117398206, 10662.093722033636, 10665.680029599125, 10624.46877656118, 10725.463726813628, 10732.892671073307, 10735.946320268427, 10739.731506712356, 10527.631532896312, 10604.151667866552, 10622.362658240492, 10622.840657390145, 10629.0, 10482.0, 10602.946985265102, 10616.734581635445, 10625.468726563719, 10909.34543927367, 43323.35014974778, 43730.562694372966, 43765.56234437646, 43797.12405751867, 43820.0, 3736.3461394255896, 4240.321548552248, 4477.48508921475, 4521.3896124023495, 4669.95330046702, 32999.835000825085, 33160.0, 33337.49993750096, 33493.0, 33798.662013380046, 4176.728512646669, 4250.42619246404, 4262.658987281041, 4288.506821715511, 4289.24938135825, 280233.0, 282012.0, 283732.0, 283786.0, 283875.0, 46686.06627867424, 59794.0, 59984.0, 60011.399886001454, 60103.0, 44095.55904440978, 44434.777826110665, 44679.0, 44703.55296446994, 44743.0, 15610.453634122978, 16140.838591613934, 16143.515694529184, 16150.35398584067, 16170.838291616934, 11520.654380368602, 12960.287184204959, 13078.869211307765, 13101.868981310256, 13159.342032898508, 15004.774928376082, 15253.16107614092, 15285.312160952784, 15292.388304467697, 15362.539123826304, 5885.793997210077, 5975.551833612496, 6083.148359229712, 6103.816885493442, 6151.5386346024225, 1062.0, 1062.946852657364, 1063.8989296016866, 1080.4057768227601, 1154.5554961339944, 30604.234894127825, 30811.8459407706, 30909.0, 30995.535066974015, 31396.529052064237, 1137.732632831284, 1181.940902954866, 1182.0, 1223.9571614993433, 1232.617888454582, 15582.364641325896, 15764.842351576566, 16019.359225631077, 16089.436869709503, 16245.756313655305, 333377.0, 337348.0, 338106.0, 338290.0, 338882.0, 58147.70926145427, 58181.709091455115, 58410.12384814231, 58466.707666462244, 58589.41410585925, 1243.7512497500536, 1411.908225965309, 1472.0725942655845, 1483.6513419346445, 1513.1299502785942, 27661.446771064868, 27676.723232767414, 27904.16287511378, 28257.293567660152, 28520.85739571289, 43649.78175109104, 43892.341614875164, 43937.34093988657, 43938.78030609826, 43989.34015989699, 184533.0, 186999.0, 187719.0, 187838.0, 188285.0, 29955.101346959626, 33362.83318583488, 34280.314393712484, 35784.642153578134, 38252.0, 44522.55477445184, 45095.77452112718, 45163.0, 45324.32013519734, 46074.769626151654, 36190.779425593064, 37535.81232093822, 37760.244795104496, 38530.2293954125, 38684.226315474094, 36976.26047479089, 37220.0, 37545.0, 37849.432258516696, 38145.0, 38354.232915342094, 38544.61455385522, 43716.56283437125, 44754.77622611866, 44821.32768008417, 31671.683283166873, 33497.0, 33766.66233337635, 34403.0, 34427.82786086053, 27735.0, 27752.8612356945, 28003.0, 28321.858390708738, 28344.43311133807], "unit": "score", "name": "ext.html", "value": 19159.123807223725}, {"lowerIsBetter": false, "replicates": [358.6843577651667, 359.5577439749109, 360.3567631777278, 368.95203623528937, 381.0644866851879, 17674.29302827887, 18248.087595620233, 18296.45110646681, 18585.721214181765, 18619.255229790793, 17960.281588736434, 18205.271789128452, 18800.529986750338, 18821.811781882177, 18823.24707011718, 5547.77808887645, 5623.915641265385, 5637.238972738689, 5668.829935101953, 5697.6866272355, 4289.6997210195295, 5621.763212093333, 5926.288845338566, 6166.506679465654, 6191.411815877507, 6118.908216376758, 6125.264968203822, 6130.295016073142, 6143.508519318466, 6147.631142131464, 5876.735546900379, 6041.365656606037, 6043.939560604382, 6054.182685337467, 6058.121572372003, 3831.7509361891666, 5104.795808167669, 5295.682259064469, 5321.148616221425, 5321.8935621287355, 20636.17455301786, 21082.472938176514, 21121.78878211229, 21485.24801631951, 21505.139794408205, 2401.21960362881, 2765.267204190891, 2801.9352645994595, 2805.1864959161817, 2841.573763935426, 13817.240051797147, 14004.92997535016, 14245.643858903506, 14410.279486025656, 14439.422423103064, 1882.6611209982198, 1907.2371051579341, 1909.789923108457, 1914.301280032778, 1914.339552854263, 63132.99999999954, 63455.365446345866, 63835.36164638387, 64579.0, 64616.0, 9751.707448776548, 9812.362196457207, 10037.0, 10047.447390393452, 10135.9493202535, 12719.364031798374, 12839.550615728405, 12840.486380544673, 12853.421596028202, 12861.164024338388, 7816.804579885435, 7923.286904178652, 8023.117457079717, 8037.799055023671, 8110.837783244302, 7790.5325680459355, 7929.32600728933, 7935.285824275843, 7982.401319901031, 8183.73152161416, 6319.115323854664, 6384.48924086072, 6390.648514331757, 6452.257990331078, 6469.708863101077, 1697.711389063862, 1708.8547473464894, 1722.1475369692082, 1750.7636469076513, 1779.1104447776113, 1012.8075665623508, 1026.771904966225, 1067.199600299775, 1127.2503784983057, 1237.7524495101015, 17876.28494860217, 17983.280668773103, 18086.0, 18279.63440731178, 18506.907465462587, 1094.485591771866, 1101.8126918423886, 1113.504490501735, 1149.1036991146918, 1149.1611123879447, 10712.732181695364, 10768.0, 10884.346939183675, 10889.564417423373, 10940.234183607072, 429628.0, 432547.0, 435739.0, 442798.0, 445941.0, 64180.67909660515, 69808.30191698119, 69963.0, 70427.29572704309, 71093.64453177805, 1104.9944750276197, 1118.8992990630882, 1174.3834486894277, 1180.6340034589305, 1182.2079206931376, 16320.67358652844, 16365.672686545964, 16454.341826326814, 16504.0, 16619.0, 32827.835860820545, 33640.1589960253, 34506.0, 34791.47812782861, 35093.649063510056, 45678.08643827171, 45838.08323833571, 46067.0, 46313.53686463092, 46398.53601464077, 7959.363250939795, 8087.231712987257, 8091.109977902308, 8225.054118776177, 8423.326133909395, 9105.863412048957, 13222.735545288848, 13344.733105338033, 13668.52160174389, 13692.041557090908, 10843.620473283398, 11002.449877506253, 11190.94404527972, 11281.943590281997, 11600.30398176112, 8676.349273804364, 11349.0, 11731.178817482694, 11788.823167652321, 11808.527658893549, 11607.36159511235, 11631.825522616999, 11761.411929403666, 11867.58463453775, 11959.461824218106, 7485.251474852689, 7504.924950750423, 7548.698052077855, 7708.922910770821, 8323.458975166595, 11590.130740194687, 11630.244034138092, 11839.70400739954, 11883.0, 11942.701432464259], "unit": "score", "name": "jquery.html", "value": 8961.242477544387}, {"lowerIsBetter": false, "replicates": [1485.4652325162947, 1542.498687926424, 1563.3824639267486, 1748.9912550437245, 1851.2132343753901, 7857.1357150713375, 8039.196080391958, 8044.477108987919, 8053.275205231528, 8054.114047454776, 7760.6119694015215, 7882.881756773653, 7885.842283154333, 7886.29023387895, 7890.644920978555, 2043.38698390483, 2076.283682129663, 2338.8128949683983, 2350.964735528964, 2379.2267513058237, 2436.987815060922, 2443.584590619599, 2446.3150317911013, 2446.5351583199226, 2448.963265551009, 2326.8720220387872, 2332.96500552491, 2371.4190023444194, 2385.522895420914, 2388.0209114263157, 2364.4443555764383, 2402.303332033708, 2405.074046492113, 2406.302172370011, 2418.7702168293986, 2362.0, 2362.267697013914, 2385.856848589073, 2386.940326491834, 2407.590709579376, 7956.2043795619975, 7978.401619878474, 7995.240452157036, 8010.078840933309, 8010.519368837889, 5065.265536497187, 5202.583793296527, 5216.739163041832, 5218.921716174261, 5219.347581552306, 3259.103746469716, 3268.215628249227, 3316.0217735768006, 3321.086701157177, 3362.36115138123, 1051.1380667852363, 1059.4808543813554, 1080.2924084724518, 1962.1268535501708, 2091.4144039668918, 10764.78470430587, 10805.783884322269, 10814.080803131743, 10822.512986915608, 10824.40465774382, 4299.914001719948, 4338.197433474817, 4372.191144638188, 4379.146066516999, 4454.643628509712, 9128.680496182602, 9170.954145229365, 9173.495457749888, 9179.357444978921, 9201.125893040151, 4901.730404827768, 4903.583195428358, 4906.656534042583, 4915.0415668944925, 4919.631027672939, 4076.2051399977313, 4549.135664223853, 4646.233371493733, 4646.303054541778, 4713.198756211452, 3542.964570354315, 3604.9098772530897, 3637.217998130415, 3690.5940346561856, 3724.0875985383755, 1111.4553868604487, 1121.7588218532892, 1126.9549218031186, 1127.1658972360394, 1130.429133287701, 1410.541573988458, 1442.3869855311661, 1458.3364569121024, 1476.9852301477063, 1518.483715536723, 7658.923410765821, 7661.961690191513, 7707.421943354271, 7716.6527506262355, 7722.3049925506975, 517.3507248403305, 518.9429162792089, 528.2498851630694, 533.9626226164131, 539.2989114151587, 5857.7656893724625, 5858.8242352729485, 5860.531157507389, 5881.911771323434, 5936.0, 9043.095690431035, 9293.349465537347, 9294.302927280482, 9412.67055653049, 9417.529123543933, 9666.033396660418, 9668.516574171263, 9859.704208873745, 9883.50582470888, 9895.901040989498, 7640.503367281221, 7782.066152061789, 7801.765947021599, 7861.646225919847, 7869.724559640385, 7518.736844210426, 7558.168601453725, 7615.390768738598, 7664.8850267244925, 7688.077430708351, 8884.289256859307, 8948.373613847229, 8971.461712297283, 9053.2304754094, 9138.771530711785, 8982.146696063863, 9333.439993600407, 9333.48665823359, 9337.71986840396, 9404.247660187031, 6229.5327850410495, 6321.273053598895, 6734.393904548614, 7170.892436613351, 7255.09311336083, 7524.360429363565, 7530.0, 7530.510516816608, 7536.5101268417375, 7570.659320330708, 6810.31896810315, 7037.507374483737, 7097.183823860322, 7140.607266600179, 7218.386437152901, 6983.476239281973, 6984.161900571964, 7042.366187043191, 7055.153381594241, 7105.928940710527, 7016.087908571853, 7032.929670703227, 7153.070100886852, 7168.928310717035, 7171.1753148386515, 6611.966940165461, 6637.203535575762, 6647.833804154935, 6660.333966603301, 6664.500162487736, 6574.704138313692, 6593.703283352356, 6616.636085015371, 6775.864482710417, 6933.618650974245], "unit": "score", "name": "mootools.html", "value": 4604.249203554605}, {"lowerIsBetter": false, "replicates": [338.7730220752096, 342.10710046777905, 343.62029956897635, 360.4881068882187, 367.67093451361035, 6095.75616975321, 6124.9693751531295, 6126.724297406617, 6127.2034635497375, 6154.876902461948, 6049.606775559597, 6053.606515576495, 6062.969685151579, 6075.726592303346, 6079.63522188669, 4465.9330110048295, 4568.406107206059, 4568.931466028012, 4573.542645735433, 4576.633869290466, 4645.674802763808, 4655.4180727409075, 4680.368150299717, 4688.9765551172195, 4691.4604820445575, 4669.042846216535, 4670.346151538787, 4670.579647831694, 4671.065786842645, 4677.228257337535, 4509.0, 4512.390827238313, 4597.3793537872625, 4628.375169352162, 4680.953190468103, 4027.033511957109, 4029.597040295976, 4029.8992525186814, 4047.655949244318, 4055.634992850628, 5767.740451679684, 5785.884282314372, 5791.536677065825, 5797.913031304533, 5799.88400231993, 5368.677879327252, 5368.865778355534, 5371.838844834661, 5373.785048598091, 5392.811251606214, 6435.485161187094, 6441.162648855666, 6443.871122577569, 6445.742170313229, 6452.419282264619, 4362.8691139265875, 4487.865364039084, 4493.887652808706, 4529.86410407685, 4535.750533720644, 6725.327467253284, 6752.493562982747, 6775.898361524581, 6779.932200677979, 6786.72853085876, 4557.840475583339, 4570.223062079454, 4573.588377046081, 4577.1074640444795, 4578.244589642672, 4636.072785442858, 4638.281066434708, 4639.582437580567, 4640.211164102111, 4640.605548528345, 5368.1679339702405, 5368.5436737876935, 5371.4897084776885, 5375.139977603565, 5377.892442151135, 6332.620042797447, 6521.119648847345, 6523.575967562093, 6531.183602049744, 6558.114654521674, 1587.547548948544, 1590.332060534555, 1592.4028489316506, 1598.352667169798, 1601.54356008537, 1046.8482070099792, 1056.8573242612304, 1080.6649938519083, 1084.6420681175193, 1094.3816743539874, 6077.058056001327, 6195.411435913581, 6302.1177035215105, 6331.556791024676, 6341.936580634135, 6748.426383757337, 6763.695633696496, 6771.322867713189, 6776.525643204928, 6780.423663988518, 6314.71583778731, 6323.470611755335, 6325.114483972247, 6326.746930122744, 6326.968365158237, 3624.7462677612316, 3653.5067765851268, 3655.305491956573, 3657.0674478007936, 3658.7438879278193, 6858.245592984767, 6978.755743548952, 7001.404880585105, 7006.124234470692, 7010.75462358815, 6867.175938887265, 6888.758893438706, 6894.448444124458, 6898.0687607173395, 6898.482613803984, 6941.097657304518, 6964.094667693167, 6971.431427928777, 6973.919042548312, 6977.0, 6725.730970761115, 6736.360045795642, 6738.6967586459705, 6741.865162696817, 6746.089277947414, 6486.902696459462, 6641.734330626721, 6646.501512386493, 6647.434968027772, 6663.600183988976, 6967.547109438073, 6984.650767461708, 6985.26654701249, 6998.54509456904, 6999.1950925644205, 4460.130274596422, 4460.1971645104195, 4461.375407443025, 4469.329600559942, 4471.61991230749, 6739.191297044386, 6739.831504212434, 6743.52795304324, 6756.797296081126, 6825.624590647562, 6399.520035997412, 6521.152250207443, 6543.378379053982, 6556.2788093310655, 6556.541042127196, 6512.446442052478, 6556.737730490918, 6558.311377305315, 6567.671616419256, 6568.211814582281, 6453.677316134268, 6461.418472337512, 6462.386073323027, 6464.997925321582, 6466.579672321284, 6589.077529145828, 6596.8350791230605, 6606.174228221473, 6608.900866486911, 6609.339066093352, 6161.784337548164, 6299.244090709144, 6447.194100737408, 6455.644939528371, 6459.838504037437], "unit": "score", "name": "prototype.html", "value": 4890.857383850977}, {"lowerIsBetter": false, "replicates": [761.6458346868704, 778.4978688745763, 857.8713193021047, 895.0646574329825, 954.8376775948091, 13551.25468099254, 14762.63093422665, 14886.478973235939, 14907.478238261663, 14932.253387330644, 12023.098267629919, 12125.939370303158, 12126.878731212708, 12129.150959432844, 12130.0, 764.8240904591947, 903.6520939438298, 921.0421161991537, 921.6405601815297, 936.7892224249557, 932.9113734195274, 936.4755736787387, 941.23759754599, 941.4774799986005, 941.6939494664227, 986.2159583131428, 989.5497548615363, 994.7015895231438, 995.5818556206375, 995.9502024898726, 801.6552882260626, 980.9313348065639, 981.175812317653, 994.7960668063103, 995.8356871116257, 736.8710475666737, 737.797105795905, 737.8634952533798, 737.9077615298088, 739.6338812287898, 13586.728265434735, 13623.659408514768, 13634.181949082988, 13634.318284085755, 13641.454341826315, 14422.134671919719, 14497.927510362486, 14516.0, 14549.054311469721, 14568.927155364261, 11098.167637427145, 11278.097752179807, 11354.545818167264, 11493.195476316578, 11556.1332900032, 3898.4542164097047, 3928.4696565963513, 3992.261431635128, 4005.61946615074, 4034.5763694811917, 50717.746411267704, 51078.489215108115, 51116.0, 51389.0, 51482.742586286826, 10341.586336546605, 10708.1433485321, 10837.729056773644, 10868.45657717111, 10911.83632245517, 19346.613067738846, 19517.0, 19527.218911243675, 19528.0, 19538.12078456473, 8282.585870706562, 8311.0, 8449.788755281168, 8457.0, 8529.530875801891, 4730.408698912636, 4802.087603355351, 4815.22956326986, 4849.175640141185, 4883.145449546315, 3252.70725634694, 3263.592050993626, 3272.640009598942, 3274.590676165479, 3277.2789986203475, 613.9416755408229, 625.7371903800415, 627.6547898655721, 629.3077614623877, 630.095812509051, 720.945929055323, 746.4625469661943, 752.3379426104992, 782.776908581063, 782.945193836426, 8520.403571750043, 8728.127187281221, 8744.956275218583, 8902.599383027778, 8904.821903562022, 602.9638221706712, 615.7290792051483, 714.5530301140129, 728.602911413281, 748.6930358552967, 4093.85671501496, 4261.190373828963, 4379.430674012358, 4397.8240870364825, 4415.40392047076, 57335.13997290044, 58371.12443313269, 58383.4161658378, 60154.0, 61236.08145877816, 51939.74030129901, 52474.0, 52824.47175528272, 52848.67878303073, 53344.73327633337, 47523.0, 47703.76148119307, 47875.76062119667, 47992.520074798806, 48074.759626201645, 9310.95344523273, 9329.72010839676, 9363.344565880323, 9474.194693451134, 9506.572204250688, 35386.646133538336, 35434.29131417305, 36032.27935441329, 36226.27547449089, 36794.448083278236, 43782.781086094365, 44665.10669786651, 44687.0, 45597.31604025876, 45947.31079033884, 11902.880971190178, 12148.574799881962, 12166.0, 12209.511619535118, 12467.75064498723, 11573.537058517564, 12578.245305281713, 12832.486700532249, 13033.543825966046, 13418.932905335801, 12286.754264914473, 12333.198342107735, 12388.876111238773, 12494.812577811159, 12577.685557861127, 11632.476538555617, 11670.591529296435, 11741.530338786353, 11802.468888899848, 11875.16873818859, 12120.151589388659, 12222.755544888874, 12303.876961230273, 12441.813372799596, 12686.619401417973, 10156.949215253877, 10234.437105959243, 10535.947320263349, 10563.260571760211, 10740.248182627141, 10156.39061656303, 10536.15710743154, 10549.73625659334, 10582.365058096539, 10586.735331616772], "unit": "score", "name": "yui.html", "value": 6800.346099929316}], "name": "dromaeo_css", "value": 7192.48997634998}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 113.0, 113.0, 112.0, 99.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 153.0, 171.0, 126.0, 153.0, 153.0, 139.0, 180.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 159.0, 160.0, 161.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 180.0, 73.0, 71.0, 75.0, 72.0, 164.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 146.0, 92.0, 94.0, 93.0, 140.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [53.0, 57.0, 56.0, 56.0, 55.0, 56.0, 58.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 77.0, 78.0, 79.0, 88.0, 78.0, 78.0, 86.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 117.0, 112.0, 111.0, 116.0, 115.0, 111.0, 110.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.5}, {"lowerIsBetter": true, "replicates": [144.0, 156.0, 140.0, 139.0, 139.0, 137.0, 140.0, 151.0, 144.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 69.0, 64.0, 66.0, 69.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1502.7}]} 09:42:37 INFO - Return code: 0 09:42:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:42:38 INFO - # TBPL SUCCESS # 09:42:38 INFO - Running post-action listener: _resource_record_post_action 09:42:38 INFO - Running post-run listener: _resource_record_post_run 09:42:39 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 421888; Write bytes: 487276544; Read time: 520; Write time: 382532 09:42:39 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244137984; Read time: 0; Write time: 234448 09:42:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 421888; Write bytes: 242540544; Read time: 520; Write time: 148084 09:42:39 INFO - Running post-run listener: _upload_blobber_files 09:42:39 INFO - Blob upload gear active. 09:42:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:42:39 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 09:42:39 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'] 09:42:39 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 09:42:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:40 INFO - (blobuploader) - INFO - Done attempting. 09:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:41 INFO - (blobuploader) - INFO - Done attempting. 09:42:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:41 INFO - Return code: 0 09:42:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:42:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01d3912ace703a0ec49fe1cd83b98e3656a2eb230832cf8efcac7d0973e37cbc0a39d96386af7000b47b2389170473785156595043d3465a13aa4316c13c8132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fe82115e81bc6caf9c04086f99adf91d3769a327a53da8925b24c8f788d2ccbe81c7c4063f0dea6c6c01cf665008d6bb259bda1f8196f9852ff9e2f1f278dd"} 09:42:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:42:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:42:41 INFO - Contents: 09:42:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01d3912ace703a0ec49fe1cd83b98e3656a2eb230832cf8efcac7d0973e37cbc0a39d96386af7000b47b2389170473785156595043d3465a13aa4316c13c8132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fe82115e81bc6caf9c04086f99adf91d3769a327a53da8925b24c8f788d2ccbe81c7c4063f0dea6c6c01cf665008d6bb259bda1f8196f9852ff9e2f1f278dd"} 09:42:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:41 INFO - Copying logs to upload dir... 09:42:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:42:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.699967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-16 09:42:40.980933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 09:42:40.984699) ========= 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 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/01d3912ace703a0ec49fe1cd83b98e3656a2eb230832cf8efcac7d0973e37cbc0a39d96386af7000b47b2389170473785156595043d3465a13aa4316c13c8132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fe82115e81bc6caf9c04086f99adf91d3769a327a53da8925b24c8f788d2ccbe81c7c4063f0dea6c6c01cf665008d6bb259bda1f8196f9852ff9e2f1f278dd"} build_url:https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/Tl8H6TmQROSW4Kf6IkxLLQ/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/01d3912ace703a0ec49fe1cd83b98e3656a2eb230832cf8efcac7d0973e37cbc0a39d96386af7000b47b2389170473785156595043d3465a13aa4316c13c8132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fe82115e81bc6caf9c04086f99adf91d3769a327a53da8925b24c8f788d2ccbe81c7c4063f0dea6c6c01cf665008d6bb259bda1f8196f9852ff9e2f1f278dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 09:42:41.010492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:42:41.010868) ========= 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=41bf3e9aed84707956354da8000001c5-1458144140.334222-184273100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 09:42:41.095541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 09:42:41.095901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 09:42:41.096241) ========= ========= Total master_lag: 0.28 =========