builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1457503200.95 results: success (0) buildid: 20160308193331 builduid: 0ad0c2b2b3c74c7aa9f6b408a5cc51f2 revision: b7fd5da36595139efc6d103249b36a5338d0efb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:00.948813) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:00.949283) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:00.949579) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:00.976137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:00.976415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.008021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.008304) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.061355) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.061878) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.062495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.062984) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 22:00:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 231M=0s 2016-03-08 22:00:01 (231 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.252268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.252568) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018867 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.304987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:01.305323) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b7fd5da36595139efc6d103249b36a5338d0efb9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b7fd5da36595139efc6d103249b36a5338d0efb9 --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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 22:00:01,509 truncating revision to first 12 chars 2016-03-08 22:00:01,509 Setting DEBUG logging. 2016-03-08 22:00:01,509 attempt 1/10 2016-03-08 22:00:01,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b7fd5da36595?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 22:00:02,063 unpacking tar archive at: mozilla-inbound-b7fd5da36595/testing/mozharness/ program finished with exit code 0 elapsedTime=0.831133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:02.149081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:02.149450) ========= echo b7fd5da36595139efc6d103249b36a5338d0efb9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b7fd5da36595139efc6d103249b36a5338d0efb9'] 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b7fd5da36595139efc6d103249b36a5338d0efb9 program finished with exit code 0 elapsedTime=0.004645 script_repo_revision: 'b7fd5da36595139efc6d103249b36a5338d0efb9' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:02.210149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:02.210482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 22:00:02.229509) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-08 22:00:02.229819) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:02 INFO - MultiFileLogger online at 20160308 22:00:02 in /builds/slave/test-pgo 22:00:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:00:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:00:02 INFO - {'append_to_log': False, 22:00:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:00:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:00:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:00:02 INFO - 'branch': 'Mozilla-Inbound', 22:00:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:02 INFO - 'config_files': ('talos/linux_config.py',), 22:00:02 INFO - 'default_actions': ('clobber', 22:00:02 INFO - 'read-buildbot-config', 22:00:02 INFO - 'download-and-extract', 22:00:02 INFO - 'populate-webroot', 22:00:02 INFO - 'create-virtualenv', 22:00:02 INFO - 'install', 22:00:02 INFO - 'run-tests'), 22:00:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:02 INFO - 'download_minidump_stackwalk': True, 22:00:02 INFO - 'download_symbols': 'ondemand', 22:00:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:02 INFO - 'installer_path': 'installer.exe', 22:00:02 INFO - 'log_level': 'info', 22:00:02 INFO - 'log_name': 'talos', 22:00:02 INFO - 'log_to_console': True, 22:00:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:02 INFO - 'opt_config_files': (), 22:00:02 INFO - 'pip_index': False, 22:00:02 INFO - 'sps_profile': False, 22:00:02 INFO - 'sps_profile_interval': 0, 22:00:02 INFO - 'suite': 'dromaeojs', 22:00:02 INFO - 'system_bits': '32', 22:00:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:02 INFO - 'title': 'talos-linux64-ix-046', 22:00:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:02 INFO - 'use_talos_json': True, 22:00:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:00:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:02 INFO - 'work_dir': 'build'} 22:00:02 INFO - ##### 22:00:02 INFO - ##### Running clobber step. 22:00:02 INFO - ##### 22:00:02 INFO - Running pre-action listener: _resource_record_pre_action 22:00:02 INFO - Running main action method: clobber 22:00:02 INFO - rmtree: /builds/slave/test-pgo/build 22:00:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:00:03 INFO - Running post-action listener: _resource_record_post_action 22:00:03 INFO - ##### 22:00:03 INFO - ##### Running read-buildbot-config step. 22:00:03 INFO - ##### 22:00:03 INFO - Running pre-action listener: _resource_record_pre_action 22:00:03 INFO - Running main action method: read_buildbot_config 22:00:03 INFO - Using buildbot properties: 22:00:03 INFO - { 22:00:03 INFO - "project": "", 22:00:03 INFO - "product": "firefox", 22:00:03 INFO - "script_repo_revision": "production", 22:00:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:00:03 INFO - "repository": "", 22:00:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:00:03 INFO - "buildid": "20160308193331", 22:00:03 INFO - "pgo_build": "True", 22:00:03 INFO - "basedir": "/builds/slave/test-pgo", 22:00:03 INFO - "buildnumber": 779, 22:00:03 INFO - "slavename": "talos-linux64-ix-046", 22:00:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:00:03 INFO - "platform": "ubuntu64_hw", 22:00:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:00:03 INFO - "branch": "mozilla-inbound", 22:00:03 INFO - "repo_path": "integration/mozilla-inbound", 22:00:03 INFO - "revision": "b7fd5da36595139efc6d103249b36a5338d0efb9", 22:00:03 INFO - "stage_platform": "linux64-pgo", 22:00:03 INFO - "builduid": "0ad0c2b2b3c74c7aa9f6b408a5cc51f2", 22:00:03 INFO - "slavebuilddir": "test" 22:00:03 INFO - } 22:00:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:00:03 INFO - Running post-action listener: _resource_record_post_action 22:00:03 INFO - ##### 22:00:03 INFO - ##### Running download-and-extract step. 22:00:03 INFO - ##### 22:00:03 INFO - Running pre-action listener: _resource_record_pre_action 22:00:03 INFO - Running main action method: download_and_extract 22:00:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:00:03 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')]} 22:00:03 INFO - https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:00:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:00:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:00:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:00:05 INFO - Downloaded 1361 bytes. 22:00:05 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:00:05 INFO - Using the following test package requirements: 22:00:05 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:00:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'jsshell-linux-x86_64.zip'], 22:00:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:05 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:05 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')]} 22:00:05 INFO - https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:06 INFO - Downloaded 23404901 bytes. 22:00:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:07 INFO - Return code: 0 22:00:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:00: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')]} 22:00:07 INFO - https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:00:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:00:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:17 INFO - Downloaded 23404901 bytes. 22:00:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:19 INFO - Return code: 0 22:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:19 INFO - https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:00:20 INFO - Downloaded 10845161 bytes. 22:00:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:20 INFO - Return code: 0 22:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:20 INFO - https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:00:21 INFO - Downloaded 56145095 bytes. 22:00:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:00:21 INFO - mkdir: /builds/slave/test-pgo/properties 22:00:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:00:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:00:21 INFO - Contents: 22:00:21 INFO - build_url:https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:00:22 INFO - Running post-action listener: _resource_record_post_action 22:00:22 INFO - Running post-action listener: set_extra_try_arguments 22:00:22 INFO - ##### 22:00:22 INFO - ##### Running populate-webroot step. 22:00:22 INFO - ##### 22:00:22 INFO - Running pre-action listener: _resource_record_pre_action 22:00:22 INFO - Running main action method: populate_webroot 22:00:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:22 INFO - '--tppagecycles', 22:00:22 INFO - '7'], 22:00:22 INFO - 'tests': ['tsvgm']}}, 22:00:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:00:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:00:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:00:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'tests': ['damp', 'tps']}, 22:00:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['damp', 'tps']}, 22:00:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:00:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:22 INFO - 'other': {'tests': ['a11yr', 22:00:22 INFO - 'ts_paint', 22:00:22 INFO - 'tpaint', 22:00:22 INFO - 'sessionrestore', 22:00:22 INFO - 'sessionrestore_no_auto_restore', 22:00:22 INFO - 'tabpaint']}, 22:00:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['a11yr', 22:00:22 INFO - 'ts_paint', 22:00:22 INFO - 'tpaint', 22:00:22 INFO - 'sessionrestore', 22:00:22 INFO - 'sessionrestore_no_auto_restore', 22:00:22 INFO - 'tabpaint']}, 22:00:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['a11yr', 22:00:22 INFO - 'ts_paint', 22:00:22 INFO - 'tpaint', 22:00:22 INFO - 'sessionrestore', 22:00:22 INFO - 'sessionrestore_no_auto_restore', 22:00:22 INFO - 'tabpaint']}, 22:00:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['a11yr', 22:00:22 INFO - 'ts_paint', 22:00:22 INFO - 'tpaint', 22:00:22 INFO - 'sessionrestore', 22:00:22 INFO - 'sessionrestore_no_auto_restore', 22:00:22 INFO - 'tabpaint']}, 22:00:22 INFO - 'other_l64': {'tests': ['a11yr', 22:00:22 INFO - 'ts_paint', 22:00:22 INFO - 'tpaint', 22:00:22 INFO - 'sessionrestore', 22:00:22 INFO - 'sessionrestore_no_auto_restore', 22:00:22 INFO - 'tabpaint']}, 22:00:22 INFO - 'other_nol64': {'tests': ['a11yr', 22:00:22 INFO - 'ts_paint', 22:00:22 INFO - 'tpaint', 22:00:22 INFO - 'sessionrestore', 22:00:22 INFO - 'sessionrestore_no_auto_restore', 22:00:22 INFO - 'tabpaint']}, 22:00:22 INFO - 'svgr': {'tests': ['tsvgx', 22:00:22 INFO - 'tsvgr_opacity', 22:00:22 INFO - 'tart', 22:00:22 INFO - 'tscrollx', 22:00:22 INFO - 'cart']}, 22:00:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['tsvgx', 22:00:22 INFO - 'tsvgr_opacity', 22:00:22 INFO - 'tart', 22:00:22 INFO - 'tscrollx', 22:00:22 INFO - 'cart']}, 22:00:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'tests': ['tp5o']}, 22:00:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'talos_options': ['--e10s'], 22:00:22 INFO - 'tests': ['tp5o']}, 22:00:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'talos_options': ['--xperf_path', 22:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:22 INFO - 'tests': ['tp5n']}, 22:00:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:22 INFO - 'talos_options': ['--e10s', 22:00:22 INFO - '--xperf_path', 22:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:22 INFO - 'tests': ['tp5n']}}, 22:00:22 INFO - 'talos.zip': {'path': '', 22:00:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:22 INFO - Running post-action listener: _resource_record_post_action 22:00:22 INFO - ##### 22:00:22 INFO - ##### Running create-virtualenv step. 22:00:22 INFO - ##### 22:00:22 INFO - Running pre-action listener: _resource_record_pre_action 22:00:22 INFO - Running main action method: create_virtualenv 22:00:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:00:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:00:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:00:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:22 INFO - Using real prefix '/usr' 22:00:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:00:23 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:25 INFO - Installing pip.................done. 22:00:25 INFO - Return code: 0 22:00:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:00:25 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')]} 22:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:25 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')]} 22:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:25 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 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:25 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 22:00:25 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 22:00:25 INFO - Using env: {'DISPLAY': ':0', 22:00:25 INFO - 'HOME': '/home/cltbld', 22:00:25 INFO - 'LANG': 'en_US.UTF-8', 22:00:25 INFO - 'LANGUAGE': 'en_US:en', 22:00:25 INFO - 'LOGNAME': 'cltbld', 22:00:25 INFO - 'MAIL': '/var/mail/cltbld', 22:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:25 INFO - 'MOZ_NO_REMOTE': '1', 22:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:25 INFO - 'NO_EM_RESTART': '1', 22:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:25 INFO - 'SHELL': '/bin/bash', 22:00:25 INFO - 'SHLVL': '1', 22:00:25 INFO - 'TERM': 'linux', 22:00:25 INFO - 'TMOUT': '86400', 22:00:25 INFO - 'USER': 'cltbld', 22:00:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:25 INFO - '_': '/tools/buildbot/bin/python'} 22:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:25 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 22:00:25 INFO - Cleaning up... 22:00:25 INFO - Return code: 0 22:00:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:00:25 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')]} 22:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:25 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')]} 22:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:25 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 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:25 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 22:00:25 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 22:00:25 INFO - Using env: {'DISPLAY': ':0', 22:00:25 INFO - 'HOME': '/home/cltbld', 22:00:25 INFO - 'LANG': 'en_US.UTF-8', 22:00:25 INFO - 'LANGUAGE': 'en_US:en', 22:00:25 INFO - 'LOGNAME': 'cltbld', 22:00:25 INFO - 'MAIL': '/var/mail/cltbld', 22:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:25 INFO - 'MOZ_NO_REMOTE': '1', 22:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:25 INFO - 'NO_EM_RESTART': '1', 22:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:25 INFO - 'SHELL': '/bin/bash', 22:00:25 INFO - 'SHLVL': '1', 22:00:25 INFO - 'TERM': 'linux', 22:00:25 INFO - 'TMOUT': '86400', 22:00:25 INFO - 'USER': 'cltbld', 22:00:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:25 INFO - '_': '/tools/buildbot/bin/python'} 22:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:25 INFO - Downloading/unpacking psutil>=0.7.1 22:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:27 INFO - Installing collected packages: psutil 22:00:27 INFO - Running setup.py install for psutil 22:00:27 INFO - building 'psutil._psutil_linux' extension 22:00:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:00:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:00:27 INFO - building 'psutil._psutil_posix' extension 22:00:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:00:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:27 INFO - Successfully installed psutil 22:00:27 INFO - Cleaning up... 22:00:28 INFO - Return code: 0 22:00:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:00:28 INFO - Using env: {'DISPLAY': ':0', 22:00:28 INFO - 'HOME': '/home/cltbld', 22:00:28 INFO - 'LANG': 'en_US.UTF-8', 22:00:28 INFO - 'LANGUAGE': 'en_US:en', 22:00:28 INFO - 'LOGNAME': 'cltbld', 22:00:28 INFO - 'MAIL': '/var/mail/cltbld', 22:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:28 INFO - 'MOZ_NO_REMOTE': '1', 22:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:28 INFO - 'NO_EM_RESTART': '1', 22:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:28 INFO - 'SHELL': '/bin/bash', 22:00:28 INFO - 'SHLVL': '1', 22:00:28 INFO - 'TERM': 'linux', 22:00:28 INFO - 'TMOUT': '86400', 22:00:28 INFO - 'USER': 'cltbld', 22:00:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:28 INFO - '_': '/tools/buildbot/bin/python'} 22:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:00:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:00:30 INFO - Installing collected packages: mozsystemmonitor 22:00:30 INFO - Running setup.py install for mozsystemmonitor 22:00:30 INFO - Successfully installed mozsystemmonitor 22:00:30 INFO - Cleaning up... 22:00:30 INFO - Return code: 0 22:00:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:00:30 INFO - Using env: {'DISPLAY': ':0', 22:00:30 INFO - 'HOME': '/home/cltbld', 22:00:30 INFO - 'LANG': 'en_US.UTF-8', 22:00:30 INFO - 'LANGUAGE': 'en_US:en', 22:00:30 INFO - 'LOGNAME': 'cltbld', 22:00:30 INFO - 'MAIL': '/var/mail/cltbld', 22:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:30 INFO - 'MOZ_NO_REMOTE': '1', 22:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:30 INFO - 'NO_EM_RESTART': '1', 22:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:30 INFO - 'SHELL': '/bin/bash', 22:00:30 INFO - 'SHLVL': '1', 22:00:30 INFO - 'TERM': 'linux', 22:00:30 INFO - 'TMOUT': '86400', 22:00:30 INFO - 'USER': 'cltbld', 22:00:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:30 INFO - '_': '/tools/buildbot/bin/python'} 22:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:30 INFO - Downloading/unpacking blobuploader==1.2.4 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:32 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:00:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:32 INFO - Downloading docopt-0.6.1.tar.gz 22:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:33 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:33 INFO - Running setup.py install for blobuploader 22:00:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:00:33 INFO - Running setup.py install for requests 22:00:33 INFO - Running setup.py install for docopt 22:00:33 INFO - Successfully installed blobuploader requests docopt 22:00:33 INFO - Cleaning up... 22:00:33 INFO - Return code: 0 22:00:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:33 INFO - Using env: {'DISPLAY': ':0', 22:00:33 INFO - 'HOME': '/home/cltbld', 22:00:33 INFO - 'LANG': 'en_US.UTF-8', 22:00:33 INFO - 'LANGUAGE': 'en_US:en', 22:00:33 INFO - 'LOGNAME': 'cltbld', 22:00:33 INFO - 'MAIL': '/var/mail/cltbld', 22:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:33 INFO - 'MOZ_NO_REMOTE': '1', 22:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:33 INFO - 'NO_EM_RESTART': '1', 22:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:33 INFO - 'SHELL': '/bin/bash', 22:00:33 INFO - 'SHLVL': '1', 22:00:33 INFO - 'TERM': 'linux', 22:00:33 INFO - 'TMOUT': '86400', 22:00:33 INFO - 'USER': 'cltbld', 22:00:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:33 INFO - '_': '/tools/buildbot/bin/python'} 22:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:33 INFO - Running setup.py (path:/tmp/pip-VyIOvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:33 INFO - Running setup.py (path:/tmp/pip-6TpSWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:34 INFO - Running setup.py (path:/tmp/pip-YDIrVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:34 INFO - Running setup.py (path:/tmp/pip-gPGz8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:34 INFO - Running setup.py (path:/tmp/pip-e7A0oC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:34 INFO - Running setup.py (path:/tmp/pip-Qu1zUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:34 INFO - Running setup.py (path:/tmp/pip-VQCBsB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:34 INFO - Running setup.py (path:/tmp/pip-JPzM5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:34 INFO - Running setup.py (path:/tmp/pip-NC3gf1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:34 INFO - Running setup.py (path:/tmp/pip-rLfT3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:34 INFO - Running setup.py (path:/tmp/pip-F4hh5s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:34 INFO - Running setup.py (path:/tmp/pip-nakOLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:34 INFO - Running setup.py (path:/tmp/pip-6OoRUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:34 INFO - Running setup.py (path:/tmp/pip-qLJ7VC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:34 INFO - Running setup.py (path:/tmp/pip-dbeESB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:34 INFO - Running setup.py (path:/tmp/pip-cQMeN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:35 INFO - Running setup.py (path:/tmp/pip-KhAC4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:35 INFO - Running setup.py install for manifestparser 22:00:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Running setup.py install for mozcrash 22:00:35 INFO - Running setup.py install for mozdebug 22:00:35 INFO - Running setup.py install for mozdevice 22:00:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Running setup.py install for mozfile 22:00:35 INFO - Running setup.py install for mozhttpd 22:00:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Running setup.py install for mozinfo 22:00:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Running setup.py install for mozInstall 22:00:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:00:35 INFO - Running setup.py install for mozleak 22:00:35 INFO - Running setup.py install for mozlog 22:00:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Running setup.py install for moznetwork 22:00:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Running setup.py install for mozprocess 22:00:36 INFO - Running setup.py install for mozprofile 22:00:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Running setup.py install for mozrunner 22:00:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Running setup.py install for mozscreenshot 22:00:36 INFO - Running setup.py install for moztest 22:00:36 INFO - Running setup.py install for mozversion 22:00:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:36 INFO - Cleaning up... 22:00:36 INFO - Return code: 0 22:00:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:36 INFO - Using env: {'DISPLAY': ':0', 22:00:36 INFO - 'HOME': '/home/cltbld', 22:00:36 INFO - 'LANG': 'en_US.UTF-8', 22:00:36 INFO - 'LANGUAGE': 'en_US:en', 22:00:36 INFO - 'LOGNAME': 'cltbld', 22:00:36 INFO - 'MAIL': '/var/mail/cltbld', 22:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:36 INFO - 'MOZ_NO_REMOTE': '1', 22:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:36 INFO - 'NO_EM_RESTART': '1', 22:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:36 INFO - 'SHELL': '/bin/bash', 22:00:36 INFO - 'SHLVL': '1', 22:00:36 INFO - 'TERM': 'linux', 22:00:36 INFO - 'TMOUT': '86400', 22:00:36 INFO - 'USER': 'cltbld', 22:00:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:36 INFO - '_': '/tools/buildbot/bin/python'} 22:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:37 INFO - Running setup.py (path:/tmp/pip-ZmRsjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:37 INFO - Running setup.py (path:/tmp/pip-oT0TWx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:37 INFO - Running setup.py (path:/tmp/pip-vS2FDQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:37 INFO - Running setup.py (path:/tmp/pip-HsOzef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:37 INFO - Running setup.py (path:/tmp/pip-FpsagT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:37 INFO - Running setup.py (path:/tmp/pip-8yN2Gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:37 INFO - Running setup.py (path:/tmp/pip-M0w4mY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:37 INFO - Running setup.py (path:/tmp/pip-HhsISD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:37 INFO - Running setup.py (path:/tmp/pip-VEVX9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:37 INFO - Running setup.py (path:/tmp/pip-b2l7UP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:37 INFO - Running setup.py (path:/tmp/pip-lGBtm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:37 INFO - Running setup.py (path:/tmp/pip-HwbM1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:37 INFO - Running setup.py (path:/tmp/pip-WqR0Fs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:38 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)) 22:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:38 INFO - Running setup.py (path:/tmp/pip-U6deZl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:38 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)) 22:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:38 INFO - Running setup.py (path:/tmp/pip-kovZ5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:38 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)) 22:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:38 INFO - Running setup.py (path:/tmp/pip-IVKbCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:38 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)) 22:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:38 INFO - Running setup.py (path:/tmp/pip-tHcFCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:38 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)) 22:00:38 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)) 22:00:38 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)) 22:00:38 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)) 22:00:38 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)) 22:00:38 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)) 22:00:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:38 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 22:00:38 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 22:00:38 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 22:00:38 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 22:00:38 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 22:00:38 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 22:00:40 INFO - Downloading blessings-1.6.tar.gz 22:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:40 INFO - Installing collected packages: blessings 22:00:40 INFO - Running setup.py install for blessings 22:00:40 INFO - Successfully installed blessings 22:00:40 INFO - Cleaning up... 22:00:40 INFO - Return code: 0 22:00:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:40 INFO - Reading from file tmpfile_stdout 22:00:40 INFO - Current package versions: 22:00:40 INFO - argparse == 1.2.1 22:00:40 INFO - blessings == 1.6 22:00:40 INFO - blobuploader == 1.2.4 22:00:40 INFO - docopt == 0.6.1 22:00:40 INFO - manifestparser == 1.1 22:00:40 INFO - mozInstall == 1.12 22:00:40 INFO - mozcrash == 0.17 22:00:40 INFO - mozdebug == 0.1 22:00:40 INFO - mozdevice == 0.48 22:00:40 INFO - mozfile == 1.2 22:00:40 INFO - mozhttpd == 0.7 22:00:40 INFO - mozinfo == 0.9 22:00:40 INFO - mozleak == 0.1 22:00:40 INFO - mozlog == 3.1 22:00:40 INFO - moznetwork == 0.27 22:00:40 INFO - mozprocess == 0.22 22:00:40 INFO - mozprofile == 0.28 22:00:40 INFO - mozrunner == 6.11 22:00:40 INFO - mozscreenshot == 0.1 22:00:40 INFO - mozsystemmonitor == 0.0 22:00:40 INFO - moztest == 0.7 22:00:40 INFO - mozversion == 1.4 22:00:40 INFO - psutil == 3.1.1 22:00:40 INFO - requests == 1.2.3 22:00:40 INFO - wsgiref == 0.1.2 22:00:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:40 INFO - Using env: {'DISPLAY': ':0', 22:00:40 INFO - 'HOME': '/home/cltbld', 22:00:40 INFO - 'LANG': 'en_US.UTF-8', 22:00:40 INFO - 'LANGUAGE': 'en_US:en', 22:00:40 INFO - 'LOGNAME': 'cltbld', 22:00:40 INFO - 'MAIL': '/var/mail/cltbld', 22:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:40 INFO - 'MOZ_NO_REMOTE': '1', 22:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:40 INFO - 'NO_EM_RESTART': '1', 22:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:40 INFO - 'SHELL': '/bin/bash', 22:00:40 INFO - 'SHLVL': '1', 22:00:40 INFO - 'TERM': 'linux', 22:00:40 INFO - 'TMOUT': '86400', 22:00:40 INFO - 'USER': 'cltbld', 22:00:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:40 INFO - '_': '/tools/buildbot/bin/python'} 22:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:00:40 INFO - Cleaning up... 22:00:40 INFO - Return code: 0 22:00:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:40 INFO - Using env: {'DISPLAY': ':0', 22:00:40 INFO - 'HOME': '/home/cltbld', 22:00:40 INFO - 'LANG': 'en_US.UTF-8', 22:00:40 INFO - 'LANGUAGE': 'en_US:en', 22:00:40 INFO - 'LOGNAME': 'cltbld', 22:00:40 INFO - 'MAIL': '/var/mail/cltbld', 22:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:40 INFO - 'MOZ_NO_REMOTE': '1', 22:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:40 INFO - 'NO_EM_RESTART': '1', 22:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:40 INFO - 'SHELL': '/bin/bash', 22:00:40 INFO - 'SHLVL': '1', 22:00:40 INFO - 'TERM': 'linux', 22:00:40 INFO - 'TMOUT': '86400', 22:00:40 INFO - 'USER': 'cltbld', 22:00:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:40 INFO - '_': '/tools/buildbot/bin/python'} 22:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:41 INFO - Downloading/unpacking jsonschema 22:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:42 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:43 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:43 INFO - warning: no files found matching '*.txt' 22:00:43 INFO - no previously-included directories found matching 'build' 22:00:43 INFO - no previously-included directories found matching 'dist' 22:00:43 INFO - no previously-included directories found matching '.git*' 22:00:43 INFO - Installing collected packages: jsonschema, functools32 22:00:43 INFO - Running setup.py install for functools32 22:00:43 INFO - warning: no files found matching '*.txt' 22:00:43 INFO - no previously-included directories found matching 'build' 22:00:43 INFO - no previously-included directories found matching 'dist' 22:00:43 INFO - no previously-included directories found matching '.git*' 22:00:43 INFO - Successfully installed jsonschema functools32 22:00:43 INFO - Cleaning up... 22:00:43 INFO - Return code: 0 22:00:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00:43 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')]} 22:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:43 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')]} 22:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:43 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 0x7f7d1fde5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22526d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', '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 22:00:43 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 22:00:43 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 22:00:43 INFO - Using env: {'DISPLAY': ':0', 22:00:43 INFO - 'HOME': '/home/cltbld', 22:00:43 INFO - 'LANG': 'en_US.UTF-8', 22:00:43 INFO - 'LANGUAGE': 'en_US:en', 22:00:43 INFO - 'LOGNAME': 'cltbld', 22:00:43 INFO - 'MAIL': '/var/mail/cltbld', 22:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:43 INFO - 'MOZ_NO_REMOTE': '1', 22:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:43 INFO - 'NO_EM_RESTART': '1', 22:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:43 INFO - 'SHELL': '/bin/bash', 22:00:43 INFO - 'SHLVL': '1', 22:00:43 INFO - 'TERM': 'linux', 22:00:43 INFO - 'TMOUT': '86400', 22:00:43 INFO - 'USER': 'cltbld', 22:00:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:43 INFO - '_': '/tools/buildbot/bin/python'} 22:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:43 INFO - Downloading/unpacking flake8 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:46 INFO - no previously-included directories found matching 'docs/_build' 22:00:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:46 INFO - Running setup.py install for pep8 22:00:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:46 INFO - no previously-included directories found matching 'docs/_build' 22:00:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:00:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:46 INFO - Cleaning up... 22:00:46 INFO - Return code: 0 22:00:46 INFO - Running post-action listener: _resource_record_post_action 22:00:46 INFO - Running post-action listener: _start_resource_monitoring 22:00:46 INFO - Starting resource monitoring. 22:00:46 INFO - ##### 22:00:46 INFO - ##### Running install step. 22:00:46 INFO - ##### 22:00:46 INFO - Running pre-action listener: _resource_record_pre_action 22:00:46 INFO - Running main action method: install 22:00:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:46 INFO - Reading from file tmpfile_stdout 22:00:46 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:46 INFO - Reading from file tmpfile_stdout 22:00:46 INFO - Output received: 22:00:46 INFO - Usage: mozinstall [options] installer 22:00:46 INFO - Options: 22:00:46 INFO - -h, --help show this help message and exit 22:00:46 INFO - -d DEST, --destination=DEST 22:00:46 INFO - Directory to install application into. [default: 22:00:46 INFO - "/builds/slave/test-pgo"] 22:00:46 INFO - --app=APP Application being installed. [default: firefox] 22:00:46 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:01:02 INFO - Reading from file tmpfile_stdout 22:01:02 INFO - Output received: 22:01:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:01:02 INFO - Running post-action listener: _resource_record_post_action 22:01:02 INFO - ##### 22:01:02 INFO - ##### Running run-tests step. 22:01:02 INFO - ##### 22:01:02 INFO - Running pre-action listener: _resource_record_pre_action 22:01:02 INFO - Running main action method: run_tests 22:01:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:01:02 INFO - Python 2.7.3 22:01:02 INFO - Return code: 0 22:01:02 INFO - grabbing minidump binary from tooltool 22:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1920>, '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 0x22e2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e2cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:01:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:01:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:01:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:02 INFO - Return code: 0 22:01:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:01:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:01:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:01:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:01:03 INFO - Return code: 0 22:01:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 22:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 22:01:03 INFO - Using env: {'DISPLAY': ':0', 22:01:03 INFO - 'HOME': '/home/cltbld', 22:01:03 INFO - 'LANG': 'en_US.UTF-8', 22:01:03 INFO - 'LANGUAGE': 'en_US:en', 22:01:03 INFO - 'LOGNAME': 'cltbld', 22:01:03 INFO - 'MAIL': '/var/mail/cltbld', 22:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:03 INFO - 'MOZ_NO_REMOTE': '1', 22:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:03 INFO - 'NO_EM_RESTART': '1', 22:01:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:01:03 INFO - 'SHELL': '/bin/bash', 22:01:03 INFO - 'SHLVL': '1', 22:01:03 INFO - 'TERM': 'linux', 22:01:03 INFO - 'TMOUT': '86400', 22:01:03 INFO - 'USER': 'cltbld', 22:01:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937', 22:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:03 INFO - '_': '/tools/buildbot/bin/python'} 22:01:03 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 22:01:03 INFO - mozversion application_buildid: 20160308193331 22:01:03 INFO - mozversion application_changeset: b7fd5da36595139efc6d103249b36a5338d0efb9 22:01:03 INFO - mozversion application_display_name: Nightly 22:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:03 INFO - mozversion application_name: Firefox 22:01:03 INFO - mozversion application_remotingname: firefox 22:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:01:03 INFO - mozversion application_vendor: Mozilla 22:01:03 INFO - mozversion application_version: 48.0a1 22:01:03 INFO - mozversion platform_buildid: 20160308193331 22:01:03 INFO - mozversion platform_changeset: b7fd5da36595139efc6d103249b36a5338d0efb9 22:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:01:03 INFO - mozversion platform_version: 48.0a1 22:01:03 INFO - using testdate: 1457503263 22:01:03 INFO - actual date: 1457503263 22:01:03 INFO - starting webserver on 'localhost:42908' 22:01:03 INFO - SUITE-START | Running 2 tests 22:01:03 INFO - TEST-START | dromaeo_css 22:01:03 INFO - operating with platform_type : linux_ 22:01:03 INFO - Initialising browser for dromaeo_css test... 22:01:03 INFO - TEST-INFO | started process 16703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8Y99X/profile http://localhost:42908/getInfo.html) 22:01:08 INFO - PROCESS | 16703 | __metrics Screen width/height:1600/1200 22:01:08 INFO - PROCESS | 16703 | colorDepth:24 22:01:08 INFO - PROCESS | 16703 | Browser inner width/height: 1024/697 22:01:08 INFO - PROCESS | 16703 | __metrics 22:01:09 ERROR - PROCESS | 16703 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:01:09 INFO - PROCESS | 16703 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:01:10 INFO - TEST-INFO | 16703: exit 0 22:01:10 INFO - Browser initialized. 22:01:10 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:10 INFO - TEST-INFO | started process 16794 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8Y99X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:21 INFO - PROCESS | 16794 | RSS: Main: 154570752 22:01:21 INFO - PROCESS | 16794 | 22:02:13 INFO - PROCESS | 16794 | 1457503333291 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] 22:04:21 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:42908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42908/tests/dromaeo/cssquery-ext.html) 22:04:22 INFO - PROCESS | 16794 | RSS: Main: 255070208 22:04:22 INFO - PROCESS | 16794 | 22:07:24 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:42908/tests/dromaeo/cssquery-ext.html (next: http://localhost:42908/tests/dromaeo/cssquery-jquery.html) 22:07:24 INFO - PROCESS | 16794 | RSS: Main: 233291776 22:07:24 INFO - PROCESS | 16794 | 22:10:26 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:42908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42908/tests/dromaeo/cssquery-mootools.html) 22:10:27 INFO - PROCESS | 16794 | RSS: Main: 236081152 22:10:27 INFO - PROCESS | 16794 | 22:13:29 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:42908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42908/tests/dromaeo/cssquery-prototype.html) 22:13:29 INFO - PROCESS | 16794 | RSS: Main: 218673152 22:13:29 INFO - PROCESS | 16794 | 22:16:32 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:42908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42908/tests/dromaeo/cssquery-yui.html) 22:16:33 INFO - PROCESS | 16794 | RSS: Main: 211214336 22:16:33 INFO - PROCESS | 16794 | 22:19:35 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:42908/tests/dromaeo/cssquery-yui.html (next: http://localhost:42908/tests/dromaeo/cssquery-dojo.html) 22:19:36 INFO - PROCESS | 16794 | RSS: Main: 282882048 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | __start_tp_report 22:19:36 INFO - PROCESS | 16794 | _x_x_mozilla_page_load 22:19:36 INFO - PROCESS | 16794 | _x_x_mozilla_page_load_details 22:19:36 INFO - PROCESS | 16794 | |i|pagename|runs| 22:19:36 INFO - PROCESS | 16794 | |0;dojo.html;3166.1134882232977;3200.3599280143976;3210.341879914618;3236.4659831127865;3268.9346213075737;5049.267856160864;5122.180451127821;5159;5179.972369490729;5280.23436601693;5137.152369858969;5181.559567436772;5197.116490196666;5202.791888324463;5222.973885130569;4618.5381461853885;4637.327587499802;4665.9066818663605;4807.927881081769;4828.034393121372;4687.8359257426;4720.291956206579;4784.3780308559835;4795.640326975474;4903.632227582928;4703.647226457995;4706.317583950308;4720.43354797423;4748.881277968044;4758.000819827823;4690.882727931795;4703.341532185496;4712.764361781898;4738.170820106502;4742.193827049376;4650.302454631798;4657.790399432034;4701.247800351927;4724.055188962221;4727.834525791581;5022.648414610979;5038.042771873333;5039.874003149914;5053.140966035746;5061.924071138936;5518.862028449281;5522.475364840334;5525.613207075467;5526.447355264481;5573.693446860421;5354.973225133849;5510.889782204374;5549.72251387429;5620.1288800236025;5622.746976386073;5153.510416510426;5163.7159956202395;5165.715885626327;5166.948330516722;5168.793248270064;5596.356419011784;5597.188407680945;5598.076317407664;5599.132134519156;5615.466530679579;5272.130098533776;5343.759530821122;5367.919481207785;5410.269613602113;5460.180972854104;5513;5519.972400137974;5520.199571062254;5521.309836270466;5523.033469142884;5200.531952124251;5496.80761173365;5497.945020549743;5499.670019798745;5551.9722401387735;5431.131019037014;5456.508914197741;5472.288602481652;5479.178123281539;5523.7238138092935;4194.140201258735;4196.223698615766;4196.433481479961;4203.201391735561;4234.661227101825;3764.7552909060823;3774.037620406779;3784;3810.447485114643;3833.2716783811543;5123.974380128076;5145.536901678792;5154.871128221825;5177.197534382177;5195.3246078009615;5433.755481003364;5462.289902312674;5478.58910581708;5485.725713714299;5510.448955104538;5059.645824792303;5141.562967147759;5144.588432925357;5146.073706732824;5271.4728527147745;4679.67242293043;4697.412823397075;4698.389209402756;4727.220008698595;4737.620990320766;5716.57125715573;5761.942380576224;5781.797637082682;5787.479126878601;5829.621074630136;5423.484768946943;5429.321334833146;5442.863928401822;5551.916721249104;5626.099824028136;5754.971225144015;5759.366469688414;5761.308642962871;5761.884762304814;5810.099434587646;5395.892082158256;5402.918956215582;5402.945970540244;5408.7566059526625;5411.107167317348;5421.756020978986;5459.836204913859;5485;5532.917006244829;5552.611317207757;5438.972805135949;5445.482679145475;5446.373667028342;5453.045716999589;5475.069238229431;5397.8380648580605;5428.7557059931605;5442.374126975448;5449.482299181572;5479.3972663007835;5127.615428842777;5279.313689220377;5303.973480132575;5332.040232757986;5365.731713414236;5357.571394288526;5376.811811586732;5377.408485066561;5379.811706590251;5388.110961691434;5269.235960785742;5271.998320319127;5275.076861549291;5275.973620131875;5318.680879147263 22:19:36 INFO - PROCESS | 16794 | |1;ext.html;518.8158203837637;530.3132443485686;589.254592939931;596.076082072787;601.6901295832647;29256.707432925665;29653.40693186135;37117.28827117284;37572.248555028884;37722.43416348757;41070.79464602673;41269;41399.379009314885;41609.58390416095;41679.583204168026;8490.40567160299;8635.784105397384;8689.56552172392;8705;8711.912880871205;8465.873011904796;8590.87113693295;8596.656133754643;8606.268467180296;8608.48349099056;8573.485590864537;8659.393842431033;8871.911280887172;8879.51162686052;8890.155435233642;8741.562921853914;8802.339824513123;8822.647094116228;8841.071687472819;8843.11568843117;8625.396222264444;8645.265152462049;8740.781480462976;8753.299736021103;8765;40589;40905.59094409047;40925;41108.38337424941;41134;3151.936961260762;3154.0380184043856;3179.538966849817;3184.8407579620925;3241.789283696552;29944.401111977855;30095.849520752476;30550.847245763853;30696.53955190674;31303.843480782678;3235.336755965045;3388.7119594834467;3422.743294252941;3463.1515278756615;3496.2133519957806;199368;200035;200519;200825.99999999854;201223;60087;60179.09731353946;60235.397646023855;60310.39689603048;60323.69838150781;68598.65700671465;69619.65190174118;69644.6517767408;69682;69842;13747.862521374858;13797;13853.584392468241;13943.790843137362;13959.302034898214;10049.497525123714;10065;10115.898841011644;10126.746831329276;10134.23993200513;20536.794632053487;20708.689369659467;20842.687359689313;20896;21621.35135945924;7837.882431763528;7937.745524334995;8001.399895007898;8012.31895288907;8112.75661730149;943.3490891284991;983.4099540275778;1000.5147503460815;1049.4385503755454;1064.5050051725984;29491.115266542038;29563.408731825242;29675.406491870042;30140.397192056036;30188.396232075676;938.7700013496737;1043.6242952537082;1056.2326704035477;1110.6945589962663;1141.2182654881433;13906.165630062229;14378.784318235235;14408.42366305357;14569.562913112624;14623.19572423527;318392;323996.5200695973;324791;325180;325698;51809.48190518122;53475;53598;53608.731956339965;53723.73138134363;1171.7422167123389;1242.1615409598485;1250.5373011985623;1324.4966912573161;1349.102846607015;25750.613740794277;27595;27673.58489622617;27981.860090699418;28025.43949121047;40927.18145637011;40932;41224.58775412328;41261.79369103135;41281.380779287734;179631;180853;180930;180963;181382;28097.859510703132;31435.84282078575;32634.83682581667;33014.5047824278;33279;38748.6125138745;39310.606893931836;39448.605513944494;39680.2063958725;39834.60165398309;32962.340753184326;33211;33311.167220819676;33477;33679;32989.67010329962;33555;33660.158496037795;33727;34028.48957265593;35551.28897421985;36032.27935441329;36360.45459318059;36571.634283657884;36678.26643467169;30637.23406914845;32502.674973250912;32578.185545361557;32614.673853262113;32630;24784.50430991334;25290.1148459803;25702.485950281265;25724.871375643;27488.862555687094 22:19:36 INFO - PROCESS | 16794 | |2;jquery.html;359.13627725320606;359.6888691282042;360.4161258760808;365.11095482500116;369.9611540788219;17132.229049692764;17409.477715668534;18482.815171848295;18780.436586902382;18821.717674234864;15799.92100039501;17610;17616;17620.559486012855;17628.118594070278;5183.6371453998145;5489.286392768954;5518.475744804237;5523.917141242885;5524.723763811813;4016.4577781999496;5492;5857.4435428634215;6094.573379863411;6128.019516877301;6052.909206361908;6060.060690592965;6065.272167339904;6079.088136779496;6095.29904061032;5780.566457515703;6128.632282063046;6133.202683651141;6147.385261473862;6148.077788331741;3610.963890361089;5215.921761173586;5381.946180538183;5401.43358426056;5408.756605952703;19788.80211197884;19981.100850461764;20086.49783755403;21447.5710485791;21476.248331308485;2239.496113374494;2240.6639004149347;2393.4854006388537;2596.5066637338846;2673.2648521656506;12654.177478463962;12991.285479298635;13287.734245315136;13471;13504.189748615114;1776.2184638758904;1819.4814477873742;1862.320253107606;1893.9715904261448;1898.3071179019557;64775.35224647741;65464.67267663631;66468.33531664718;66881.66559167222;67106.32234194136;9868.457234852009;10117.949410252902;10250.538725757358;10253.84619230712;10433.843492347622;13542.187468751907;13546.796798048037;13628.250446225355;13660.65848353799;13662.726745465234;7013.859722805515;7134.32223938725;7148.392386647193;7240.058792357066;7254.637268136677;6737.787198304352;6796.76211332601;6898.1377327834025;6913.2049814270995;6931.930680693229;6070.3929607038945;6168.383161683885;6170.784022559279;6187.071939209155;6203.720832562545;1692.1454665393896;1703.7018521758644;1731.4936005675142;1821.3625231169249;1831.6519861226325;930.63240020193;935.7426707655313;968.5738275158908;1066.0991462214417;1068.5084860963889;16135.273912673958;16412.75380869288;17390.391336303168;17613.471595852145;18342.449726508225;942.5146049784366;962.1821451765943;974.133021610767;1015.827309357411;1025.8461230815287;9668.129868311886;9962.501874906226;9996.350237234556;9998.150157236716;10138.341007834615;454534;460664.9126047816;470462;473452;474182;69974.65012674904;71029;78786.60606697045;80979.5951020253;81799.5910020446;1000.6191455791108;1014.3913651808856;1018.266847869518;1044.566504900473;1045.7124290820086;14686.853131468975;14864.777028344368;15116.924415378293;15201.543953681406;15410.306536205673;24766.876165619058;32120.518192226667;32642.878212916083;33024.1743956403;33410.16474588155;46366.76816615895;50005.74997124991;51558;51710.482895170564;52060.21909671282;7552.169261381354;7661.080670319375;7690;7838.804029899298;7881.172476890073;9206;9544.522773861418;11892.821607675718;11935.701607459883;12257;10606.469676516297;10684.392416948076;10748.89251107479;10780.137588993019;10792.406417646791;10483.528241229316;10707.19696022817;10762.19283553721;10885.836712449161;10970.506327215135;10680.465976700978;10902.945485272523;11029.724256893642;11116.944415277872;11263.549458021915;8107.635156418093;8181.181881811771;8237.958810205912;8304.83390332202;8374.330053595575;10461.47692615351;11097.722556936142;11261.099112070851;11302.660920172408;11362.431878406212 22:19:36 INFO - PROCESS | 16794 | |3;mootools.html;1355.6475316417727;1479.578320178749;1485.8662720355169;1635.5256975477112;1778.9911050444737;7754.340881025112;7937.484063535866;7950.522968621886;7951.642176102075;7958.721444749435;7807.375409967203;8008.919910800891;8012.5593092379895;8014.479058861185;8016.519008859458;2006.939791806241;2302.5625131225097;2310.4223944013997;2338.8362814602983;2375.2043065573052;2332.4285550040263;2342.203650758742;2349.5418393413293;2353.729321128075;2359.091749676378;2226.755056943735;2281.863088214704;2282.1213832674375;2282.543491301738;2288.25631669708;2307.4231442139467;2331.1025255276672;2353.599888019041;2355.0344358812977;2363.7163540375263;2338.0063473024065;2347.5774360615083;2351.130081869719;2357.834951553392;2364.4679947011955;8106.63520141595;8113.634886430124;8160.102388737234;8160.714374996906;8172.754817355489;4722.456917454502;4838.129136755382;4845.733484658343;4849.709017458928;4849.806007759686;2900.361920377514;2984.5373967035143;3034.5903303054247;3056.098450956973;3065.8160510369225;966.1739212972877;968.3512046928574;970.427447805798;991.2317953586029;991.9156871665917;10633.096186824128;10752.78494430115;10796.73008174794;10806.35161890289;10817;4369.847055353048;4442.711223770445;4473.619742321939;4490.820367185342;4563.794629241692;9278.211352035152;9322.394044387092;9328.300377471716;9335.906640933505;9340.252779777602;4502.707324023993;4849.224124140121;4850.029994001144;4858.975705121452;4860.270959356054;4104.748051844216;4152.4601801765575;4152.979235103805;4411.051623900877;4492.034212644297;3776.50905382304;3841.9039524012123;3844.692424606025;3879.2241551689776;3918.45141680165;1221.8900298973135;1230.8030715085542;1240.4232032105115;1248.843894513186;1261.5899832554458;1368.945242190321;1396.385590340247;1404.2136403613804;1415.4621243927243;1416.0229441685203;7595.658195381221;7819.569923654253;7821.882671759929;7822.06135263772;7828.530288182727;498.9675671081368;512.5848063068926;517.4385791416355;521.1557277210943;526.0347262772779;5873.089671100986;5933.614315069507;5937.228160339128;5984.31180414258;5986.2517185351835;9228.769280768034;9295.860562091573;9299.72100836976;9429.76425589352;9460.95269523648;9272.30457715674;9276;9296.999999999865;9313.44119352841;9324.207442367338;7402.925970740332;7701.152873183945;7739.458237923292;7751.844963100706;7761.223877612194;7418.258174182539;7586.468947173866;7714.1128770192145;7720.806979825325;7722.266384693445;8499.32005439551;8504.53225072627;8751.868721969304;8752.956235218782;8807.823843523222;8729.476231426135;8972.551372431222;9060.728178154666;9062.275017998676;9068.138526839939;6334.619922804646;6859.314068593101;6913.792586222421;7018.438524918097;7040.0847889774;7578.280063393969;7578.696852125853;7612.581308028111;7638.388928885787;7653.961730191313;6752.054712340375;6883.174019117738;6885.586864788129;6984.3364880336285;6999.0551275577145;6569.835754106186;6624.503162262753;6756.493263005393;6826.41975432074;6883.965580172067;7055.717771289296;7141.107361579802;7145.17830449505;7168.89246661311;7251.746188883364;6427.903581446189;6481.935180648133;6510.641914694737;6514.218293804774;6520.576162549419;6630.900536492053;6666.033425153229;6694.564853284521;6723.361280678328;6728.865422691617 22:19:36 INFO - PROCESS | 16794 | |4;prototype.html;335.30926291838813;343.63059710810876;345.28181382723926;349.1707195410899;351.59039718727684;5708.486236238738;5767.5962682612235;5819.592628516;5838.737256823442;5853.443922827335;5741.770329186838;5753.223314852494;5762.827115186541;5763.308402991636;5776.075827867542;4229.830806767725;4372.934405983897;4397.20850246957;4398.692091553593;4401.581849724271;4443.422355093833;4515.435570553681;4525.728456292633;4529.932051019221;4530.682852200347;4425.31407631816;4457.398251236074;4462;4465.30787727901;4471.530489298626;4272.9359059614135;4318.82724691012;4368.776742512102;4439.4672639283335;4468.553144685522;3882.611738826123;3885.902852428712;3894.065424298148;3897.9610203897882;3920.8431662733456;5509.449055094458;5515.283013208297;5516.558675305966;5519.061759500854;5522.91715624266;5112.565431938289;5125.4618265082;5126.154584349669;5128.974355128238;5131.153359695646;6068.726907289182;6070.96964515179;6072.787452439144;6078;6078.817635470943;4334.263175260182;4338.544452832439;4339.71791833533;4342.565743425664;4342.9348559771315;6111.480524155452;6326.734653069405;6392.904106438361;6402.103705481283;6411.0383442484;4274.059706864485;4330.112326972963;4332.090261045153;4336.891577710519;4338.783060846945;4374.03771170342;4378.10248898975;4381.518033016366;4382.737035777864;4389.780510974439;5058.595312375075;5062.240663900445;5065.088284108896;5065.468125846806;5082.33929589151;6149.846253843601;6152.938470615326;6160.476359509402;6162.476189523941;6174.44430001302;1499.895007349475;1527.2516466931345;1544.5289186797909;1548.7599422089595;1563.1949545983828;998.6854140945579;1003.6035765872585;1004.6232662751469;1010.5553556435145;1013.7060252526685;5682.801101961411;5797.623154494944;5837.307180917572;5881.705914704333;5907.32065812437;6306.369363063657;6310.211223597051;6319.652419116993;6334.619922804646;6336.04959256106;5886.146508756292;5888.941110588925;5895.263092113486;5898.3216930053595;5903.026000709835;3343.6154842192973;3383.780054296463;3391.6608339165887;3415.55597772288;3417.3677869594203;6451.838704032437;6623.503237257225;6663.06717059612;6690.866182676319;6753.797386078426;6497.090407342976;6525.771597994048;6526.804195874131;6537.280899101095;6540.149780528501;6709.899351509634;6720.630365329856;6722.29415911332;6724.125863637793;6726.6972986216715;6304.401081897213;6333.20834895638;6341.080543321101;6349.079383489276;6353.68231588428;6162.938370616236;6289.245290565162;6291.622502649856;6298.559100862895;6299.275583307978;6652.667366631552;6713.060171576081;6717.328267173439;6724.663766811542;6724.865502689821;4318.654507639319;4373.928387545072;4375.868723938287;4376.6717496187275;4380.817179361618;6298.653574053471;6310.2743184534365;6341.27075386318;6343.11196432509;6360.618362898241;6161.4146656067605;6184.226971628546;6188.164597779242;6190.164327815687;6190.164327815687;5962.433568810956;6166.445019948226;6166.445019948226;6168.228971378578;6222.875542489034;6056.910365923749;6074.3318234994995;6100;6110.26676798787;6122;6241.843953901189;6245.219347581552;6250.687465626791;6253.749850005949;6257.4994000480765;5836.562257830595;6108.419700128481;6110.663913484801;6111.694415279129;6117.1741814856205 22:19:36 INFO - PROCESS | 16794 | |5;yui.html;549.9477549632784;569.8347479231023;623.4638211138422;706.5937086175448;712.836047709027;14021.859781402183;14109;14129.999999999987;14140.50508232212;14144.292785360729;13144.01419893507;13175.604731858035;13179.143355681874;13241.735165296688;13477.05660603758;828.2711214131556;839.0770152831897;839.3285371702644;839.3578912132224;841.0244116824484;823.5141266652673;829.722043115557;841.486693117198;841.6717480182703;842.9157084291583;861.1130535548364;864.1574464896738;872.7381785464368;872.9825403491926;874.0254616103063;851.8466675998318;858.3390789092396;866.5060915278294;866.653338664536;868.5874209750381;644.7453255963868;645.3353046362255;646.5344951634816;646.6411141816291;647.1522305779397;13996;14006;14093.577192684235;14102.85897141036;14106.647333816634;11989.460474278678;12157.270563766115;12202.816957745641;12243.93878030613;12542.05934554912;9761.414315141043;9803.065628255328;9867.90132098677;9912.702618921443;10025.498725063791;3498.9650103498893;3525.3830579648716;3539.7876127432437;3550.55618047744;3607.5670919489567;43461.13077738459;47741;48082.03835923262;48634.756826216;50240.74879625615;9037.096290371042;9065.093490650883;9328.440293582407;9360.157585817173;9481.383710058963;19101.331453399063;19128.330508432417;19132.330368437037;19329.4201173965;19366.806331936783;6884.4148247399535;7517.210692877278;7889.684412623431;8057.798555036054;8144;4339.761313127745;4424.424824772759;4565.315202719552;4749.35883655702;4822.252550854623;3141.9057428277188;3142.701443362877;3147.7167054964707;3155.873765049418;3189.027346659291;592.410551501259;599.4515018757788;607.5898768331359;616.3589866538839;616.4144063140035;628.9811305660837;638.8850006998692;647.7668039505775;657.385344702695;691.7336825322287;7591.924080759121;7726.729564465217;7872.606369681493;7942.801429964297;7966.7609971699785;517.7230181852691;609.929573598341;641.6695401868042;676.9356911093438;695.9443244540424;3599.352116618981;3607.981960090183;3641.089727568108;3649.835757390924;3735.6451137141926;54522;55884;56421.43578564244;56461.71769141128;56660;48901.266481002815;49476.062872454815;49567.75216123968;49594;50311.24533132006;42823;48318.27522587164;50830.491695083314;51261.74369128131;52250.477495226085;7991.560464174526;8025.759227223192;8179.509229446252;8285.088640249447;8326.25063744266;34560.65439345574;35143;35480.645193548764;36140;37245.813770930974;42341.78829105835;43853.78073109614;43929.78035109804;43975.560244397144;45000;10510.737231569272;10721.624743134265;10911.345319280868;11003.17476189305;11267.380294083903;11217.742378193441;11350.94324528372;11362.14783891195;11765.294082354743;11939.582114625946;10242.590296388062;10458.63394781179;10610.522526486173;10620.362778233331;10939.234253602172;10837;11177.273477223955;11201.943990279997;11357.37534435614;11433.714157146138;10251.948740256252;10604.681859544226;10657.893421066;10891.67324980252;10906.127509799038;9267.86098208514;9280.997798972898;9450.763730906783;9656.613735450785;9758.75603109928;8589.355798315026;9006.954965225394;9007.697108383596;9013.233875120426;9495.477748723886 22:19:36 INFO - PROCESS | 16794 | __end_tp_report 22:19:36 INFO - PROCESS | 16794 | __start_cc_report 22:19:36 INFO - PROCESS | 16794 | _x_x_mozilla_cycle_collect,832 22:19:36 INFO - PROCESS | 16794 | __end_cc_report 22:19:36 INFO - PROCESS | 16794 | __startTimestamp1457504376049__endTimestamp 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | ------- Summary: start ------- 22:19:36 INFO - PROCESS | 16794 | Number of tests: 6 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | [#0] dojo.html Cycles:165 Average:5125.26 Median:5280.23 stddev:551.11 (10.4%) stddev-sans-first:530.93 22:19:36 INFO - PROCESS | 16794 | Values: 3166.1 3200.4 3210.3 3236.5 3268.9 5049.3 5122.2 5159.0 5180.0 5280.2 5137.2 5181.6 5197.1 5202.8 5223.0 4618.5 4637.3 4665.9 4807.9 4828.0 4687.8 4720.3 4784.4 4795.6 4903.6 4703.6 4706.3 4720.4 4748.9 4758.0 4690.9 4703.3 4712.8 4738.2 4742.2 4650.3 4657.8 4701.2 4724.1 4727.8 5022.6 5038.0 5039.9 5053.1 5061.9 5518.9 5522.5 5525.6 5526.4 5573.7 5355.0 5510.9 5549.7 5620.1 5622.7 5153.5 5163.7 5165.7 5166.9 5168.8 5596.4 5597.2 5598.1 5599.1 5615.5 5272.1 5343.8 5367.9 5410.3 5460.2 5513.0 5520.0 5520.2 5521.3 5523.0 5200.5 5496.8 5497.9 5499.7 5552.0 5431.1 5456.5 5472.3 5479.2 5523.7 4194.1 4196.2 4196.4 4203.2 4234.7 3764.8 3774.0 3784.0 3810.4 3833.3 5124.0 5145.5 5154.9 5177.2 5195.3 5433.8 5462.3 5478.6 5485.7 5510.4 5059.6 5141.6 5144.6 5146.1 5271.5 4679.7 4697.4 4698.4 4727.2 4737.6 5716.6 5761.9 5781.8 5787.5 5829.6 5423.5 5429.3 5442.9 5551.9 5626.1 5755.0 5759.4 5761.3 5761.9 5810.1 5395.9 5402.9 5402.9 5408.8 5411.1 5421.8 5459.8 5485.0 5532.9 5552.6 5439.0 5445.5 5446.4 5453.0 5475.1 5397.8 5428.8 5442.4 5449.5 5479.4 5127.6 5279.3 5304.0 5332.0 5365.7 5357.6 5376.8 5377.4 5379.8 5388.1 5269.2 5272.0 5275.1 5276.0 5318.7 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | [#1] ext.html Cycles:180 Average:41295.78 Median:33607.58 stddev:63757.11 (189.7%) stddev-sans-first:63862.45 22:19:36 INFO - PROCESS | 16794 | Values: 518.8 530.3 589.3 596.1 601.7 29256.7 29653.4 37117.3 37572.2 37722.4 41070.8 41269.0 41399.4 41609.6 41679.6 8490.4 8635.8 8689.6 8705.0 8711.9 8465.9 8590.9 8596.7 8606.3 8608.5 8573.5 8659.4 8871.9 8879.5 8890.2 8741.6 8802.3 8822.6 8841.1 8843.1 8625.4 8645.3 8740.8 8753.3 8765.0 40589.0 40905.6 40925.0 41108.4 41134.0 3151.9 3154.0 3179.5 3184.8 3241.8 29944.4 30095.8 30550.8 30696.5 31303.8 3235.3 3388.7 3422.7 3463.2 3496.2 199368.0 200035.0 200519.0 200826.0 201223.0 60087.0 60179.1 60235.4 60310.4 60323.7 68598.7 69619.7 69644.7 69682.0 69842.0 13747.9 13797.0 13853.6 13943.8 13959.3 10049.5 10065.0 10115.9 10126.7 10134.2 20536.8 20708.7 20842.7 20896.0 21621.4 7837.9 7937.7 8001.4 8012.3 8112.8 943.3 983.4 1000.5 1049.4 1064.5 29491.1 29563.4 29675.4 30140.4 30188.4 938.8 1043.6 1056.2 1110.7 1141.2 13906.2 14378.8 14408.4 14569.6 14623.2 318392.0 323996.5 324791.0 325180.0 325698.0 51809.5 53475.0 53598.0 53608.7 53723.7 1171.7 1242.2 1250.5 1324.5 1349.1 25750.6 27595.0 27673.6 27981.9 28025.4 40927.2 40932.0 41224.6 41261.8 41281.4 179631.0 180853.0 180930.0 180963.0 181382.0 28097.9 31435.8 32634.8 33014.5 33279.0 38748.6 39310.6 39448.6 39680.2 39834.6 32962.3 33211.0 33311.2 33477.0 33679.0 32989.7 33555.0 33660.2 33727.0 34028.5 35551.3 36032.3 36360.5 36571.6 36678.3 30637.2 32502.7 32578.2 32614.7 32630.0 24784.5 25290.1 25702.5 25724.9 27488.9 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | [#2] jquery.html Cycles:180 Average:26503.86 Median:33217.17 stddev:76496.31 (230.3%) stddev-sans-first:76685.72 22:19:36 INFO - PROCESS | 16794 | Values: 359.1 359.7 360.4 365.1 370.0 17132.2 17409.5 18482.8 18780.4 18821.7 15799.9 17610.0 17616.0 17620.6 17628.1 5183.6 5489.3 5518.5 5523.9 5524.7 4016.5 5492.0 5857.4 6094.6 6128.0 6052.9 6060.1 6065.3 6079.1 6095.3 5780.6 6128.6 6133.2 6147.4 6148.1 3611.0 5215.9 5381.9 5401.4 5408.8 19788.8 19981.1 20086.5 21447.6 21476.2 2239.5 2240.7 2393.5 2596.5 2673.3 12654.2 12991.3 13287.7 13471.0 13504.2 1776.2 1819.5 1862.3 1894.0 1898.3 64775.4 65464.7 66468.3 66881.7 67106.3 9868.5 10117.9 10250.5 10253.8 10433.8 13542.2 13546.8 13628.3 13660.7 13662.7 7013.9 7134.3 7148.4 7240.1 7254.6 6737.8 6796.8 6898.1 6913.2 6931.9 6070.4 6168.4 6170.8 6187.1 6203.7 1692.1 1703.7 1731.5 1821.4 1831.7 930.6 935.7 968.6 1066.1 1068.5 16135.3 16412.8 17390.4 17613.5 18342.4 942.5 962.2 974.1 1015.8 1025.8 9668.1 9962.5 9996.4 9998.2 10138.3 454534.0 460664.9 470462.0 473452.0 474182.0 69974.7 71029.0 78786.6 80979.6 81799.6 1000.6 1014.4 1018.3 1044.6 1045.7 14686.9 14864.8 15116.9 15201.5 15410.3 24766.9 32120.5 32642.9 33024.2 33410.2 46366.8 50005.7 51558.0 51710.5 52060.2 7552.2 7661.1 7690.0 7838.8 7881.2 9206.0 9544.5 11892.8 11935.7 12257.0 10606.5 10684.4 10748.9 10780.1 10792.4 10483.5 10707.2 10762.2 10885.8 10970.5 10680.5 10902.9 11029.7 11116.9 11263.5 8107.6 8181.2 8238.0 8304.8 8374.3 10461.5 11097.7 11261.1 11302.7 11362.4 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | [#3] mootools.html Cycles:180 Average:5563.40 Median:6545.21 stddev:2900.50 (44.3%) stddev-sans-first:2891.39 22:19:36 INFO - PROCESS | 16794 | Values: 1355.6 1479.6 1485.9 1635.5 1779.0 7754.3 7937.5 7950.5 7951.6 7958.7 7807.4 8008.9 8012.6 8014.5 8016.5 2006.9 2302.6 2310.4 2338.8 2375.2 2332.4 2342.2 2349.5 2353.7 2359.1 2226.8 2281.9 2282.1 2282.5 2288.3 2307.4 2331.1 2353.6 2355.0 2363.7 2338.0 2347.6 2351.1 2357.8 2364.5 8106.6 8113.6 8160.1 8160.7 8172.8 4722.5 4838.1 4845.7 4849.7 4849.8 2900.4 2984.5 3034.6 3056.1 3065.8 966.2 968.4 970.4 991.2 991.9 10633.1 10752.8 10796.7 10806.4 10817.0 4369.8 4442.7 4473.6 4490.8 4563.8 9278.2 9322.4 9328.3 9335.9 9340.3 4502.7 4849.2 4850.0 4859.0 4860.3 4104.7 4152.5 4153.0 4411.1 4492.0 3776.5 3841.9 3844.7 3879.2 3918.5 1221.9 1230.8 1240.4 1248.8 1261.6 1368.9 1396.4 1404.2 1415.5 1416.0 7595.7 7819.6 7821.9 7822.1 7828.5 499.0 512.6 517.4 521.2 526.0 5873.1 5933.6 5937.2 5984.3 5986.3 9228.8 9295.9 9299.7 9429.8 9461.0 9272.3 9276.0 9297.0 9313.4 9324.2 7402.9 7701.2 7739.5 7751.8 7761.2 7418.3 7586.5 7714.1 7720.8 7722.3 8499.3 8504.5 8751.9 8753.0 8807.8 8729.5 8972.6 9060.7 9062.3 9068.1 6334.6 6859.3 6913.8 7018.4 7040.1 7578.3 7578.7 7612.6 7638.4 7654.0 6752.1 6883.2 6885.6 6984.3 6999.1 6569.8 6624.5 6756.5 6826.4 6884.0 7055.7 7141.1 7145.2 7168.9 7251.7 6427.9 6481.9 6510.6 6514.2 6520.6 6630.9 6666.0 6694.6 6723.4 6728.9 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | [#4] prototype.html Cycles:180 Average:5149.76 Median:5838.02 stddev:1561.59 (26.7%) stddev-sans-first:1523.59 22:19:36 INFO - PROCESS | 16794 | Values: 335.3 343.6 345.3 349.2 351.6 5708.5 5767.6 5819.6 5838.7 5853.4 5741.8 5753.2 5762.8 5763.3 5776.1 4229.8 4372.9 4397.2 4398.7 4401.6 4443.4 4515.4 4525.7 4529.9 4530.7 4425.3 4457.4 4462.0 4465.3 4471.5 4272.9 4318.8 4368.8 4439.5 4468.6 3882.6 3885.9 3894.1 3898.0 3920.8 5509.4 5515.3 5516.6 5519.1 5522.9 5112.6 5125.5 5126.2 5129.0 5131.2 6068.7 6071.0 6072.8 6078.0 6078.8 4334.3 4338.5 4339.7 4342.6 4342.9 6111.5 6326.7 6392.9 6402.1 6411.0 4274.1 4330.1 4332.1 4336.9 4338.8 4374.0 4378.1 4381.5 4382.7 4389.8 5058.6 5062.2 5065.1 5065.5 5082.3 6149.8 6152.9 6160.5 6162.5 6174.4 1499.9 1527.3 1544.5 1548.8 1563.2 998.7 1003.6 1004.6 1010.6 1013.7 5682.8 5797.6 5837.3 5881.7 5907.3 6306.4 6310.2 6319.7 6334.6 6336.0 5886.1 5888.9 5895.3 5898.3 5903.0 3343.6 3383.8 3391.7 3415.6 3417.4 6451.8 6623.5 6663.1 6690.9 6753.8 6497.1 6525.8 6526.8 6537.3 6540.1 6709.9 6720.6 6722.3 6724.1 6726.7 6304.4 6333.2 6341.1 6349.1 6353.7 6162.9 6289.2 6291.6 6298.6 6299.3 6652.7 6713.1 6717.3 6724.7 6724.9 4318.7 4373.9 4375.9 4376.7 4380.8 6298.7 6310.3 6341.3 6343.1 6360.6 6161.4 6184.2 6188.2 6190.2 6190.2 5962.4 6166.4 6166.4 6168.2 6222.9 6056.9 6074.3 6100.0 6110.3 6122.0 6241.8 6245.2 6250.7 6253.7 6257.5 5836.6 6108.4 6110.7 6111.7 6117.2 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - PROCESS | 16794 | [#5] yui.html Cycles:180 Average:13676.00 Median:49917.37 stddev:15899.41 (31.9%) stddev-sans-first:15913.45 22:19:36 INFO - PROCESS | 16794 | Values: 549.9 569.8 623.5 706.6 712.8 14021.9 14109.0 14130.0 14140.5 14144.3 13144.0 13175.6 13179.1 13241.7 13477.1 828.3 839.1 839.3 839.4 841.0 823.5 829.7 841.5 841.7 842.9 861.1 864.2 872.7 873.0 874.0 851.8 858.3 866.5 866.7 868.6 644.7 645.3 646.5 646.6 647.2 13996.0 14006.0 14093.6 14102.9 14106.6 11989.5 12157.3 12202.8 12243.9 12542.1 9761.4 9803.1 9867.9 9912.7 10025.5 3499.0 3525.4 3539.8 3550.6 3607.6 43461.1 47741.0 48082.0 48634.8 50240.7 9037.1 9065.1 9328.4 9360.2 9481.4 19101.3 19128.3 19132.3 19329.4 19366.8 6884.4 7517.2 7889.7 8057.8 8144.0 4339.8 4424.4 4565.3 4749.4 4822.3 3141.9 3142.7 3147.7 3155.9 3189.0 592.4 599.5 607.6 616.4 616.4 629.0 638.9 647.8 657.4 691.7 7591.9 7726.7 7872.6 7942.8 7966.8 517.7 609.9 641.7 676.9 695.9 3599.4 3608.0 3641.1 3649.8 3735.6 54522.0 55884.0 56421.4 56461.7 56660.0 48901.3 49476.1 49567.8 49594.0 50311.2 42823.0 48318.3 50830.5 51261.7 52250.5 7991.6 8025.8 8179.5 8285.1 8326.3 34560.7 35143.0 35480.6 36140.0 37245.8 42341.8 43853.8 43929.8 43975.6 45000.0 10510.7 10721.6 10911.3 11003.2 11267.4 11217.7 11350.9 11362.1 11765.3 11939.6 10242.6 10458.6 10610.5 10620.4 10939.2 10837.0 11177.3 11201.9 11357.4 11433.7 10251.9 10604.7 10657.9 10891.7 10906.1 9267.9 9281.0 9450.8 9656.6 9758.8 8589.4 9007.0 9007.7 9013.2 9495.5 22:19:36 INFO - PROCESS | 16794 | -------- Summary: end -------- 22:19:36 INFO - PROCESS | 16794 | 22:19:36 INFO - TEST-INFO | 16794: exit 0 22:19:36 INFO - TEST-OK | dromaeo_css | took 1112815ms 22:19:36 INFO - TEST-START | kraken 22:19:36 INFO - operating with platform_type : linux_ 22:19:36 INFO - Initialising browser for kraken test... 22:19:36 INFO - TEST-INFO | started process 16977 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAiDOm8/profile http://localhost:42908/getInfo.html) 22:19:40 INFO - PROCESS | 16977 | __metrics Screen width/height:1600/1200 22:19:40 INFO - PROCESS | 16977 | colorDepth:24 22:19:40 INFO - PROCESS | 16977 | Browser inner width/height: 1024/697 22:19:40 INFO - PROCESS | 16977 | __metrics 22:19:41 ERROR - PROCESS | 16977 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:19:41 INFO - PROCESS | 16977 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:19:42 INFO - TEST-INFO | 16977: exit 0 22:19:42 INFO - Browser initialized. 22:19:42 INFO - Running cycle 1/1 for kraken test... 22:19:42 INFO - TEST-INFO | started process 17059 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAiDOm8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:54 INFO - PROCESS | 17059 | RSS: Main: 154816512 22:19:54 INFO - PROCESS | 17059 | 22:19:56 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42908/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:57 INFO - PROCESS | 17059 | RSS: Main: 195538944 22:19:57 INFO - PROCESS | 17059 | 22:20:00 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42908/tests/kraken/driver.html?testName=audio-dft) 22:20:00 INFO - PROCESS | 17059 | RSS: Main: 184737792 22:20:00 INFO - PROCESS | 17059 | 22:20:03 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42908/tests/kraken/driver.html?testName=audio-fft) 22:20:04 INFO - PROCESS | 17059 | RSS: Main: 171020288 22:20:04 INFO - PROCESS | 17059 | 22:20:06 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42908/tests/kraken/driver.html?testName=audio-oscillator) 22:20:06 INFO - PROCESS | 17059 | RSS: Main: 172437504 22:20:06 INFO - PROCESS | 17059 | 22:20:09 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:09 INFO - PROCESS | 17059 | RSS: Main: 173867008 22:20:09 INFO - PROCESS | 17059 | 22:20:12 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42908/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:13 INFO - PROCESS | 17059 | RSS: Main: 174743552 22:20:13 INFO - PROCESS | 17059 | 22:20:16 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42908/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:17 INFO - PROCESS | 17059 | RSS: Main: 176754688 22:20:17 INFO - PROCESS | 17059 | 22:20:19 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42908/tests/kraken/driver.html?testName=json-parse-financial) 22:20:20 INFO - PROCESS | 17059 | RSS: Main: 176754688 22:20:20 INFO - PROCESS | 17059 | 22:20:22 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:22 INFO - PROCESS | 17059 | RSS: Main: 186724352 22:20:22 INFO - PROCESS | 17059 | 22:20:24 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:25 INFO - PROCESS | 17059 | RSS: Main: 182198272 22:20:25 INFO - PROCESS | 17059 | 22:20:27 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:27 INFO - PROCESS | 17059 | RSS: Main: 190840832 22:20:27 INFO - PROCESS | 17059 | 22:20:30 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:30 INFO - PROCESS | 17059 | RSS: Main: 199495680 22:20:30 INFO - PROCESS | 17059 | 22:20:33 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:33 INFO - PROCESS | 17059 | RSS: Main: 198127616 22:20:33 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:42908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42908/tests/kraken/driver.html?testName=ai-astar) 22:20:35 INFO - PROCESS | 17059 | RSS: Main: 260608000 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | __start_tp_report 22:20:35 INFO - PROCESS | 17059 | _x_x_mozilla_page_load 22:20:35 INFO - PROCESS | 17059 | _x_x_mozilla_page_load_details 22:20:35 INFO - PROCESS | 17059 | |i|pagename|runs| 22:20:35 INFO - PROCESS | 17059 | |0;ai-astar;110;111;106;110;111;111;99;112;111;110 22:20:35 INFO - PROCESS | 17059 | |1;audio-beat-detection;156;128;152;176;129;152;151;136;191;128 22:20:35 INFO - PROCESS | 17059 | |2;audio-dft;162;163;162;161;162;162;159;163;161;163 22:20:35 INFO - PROCESS | 17059 | |3;audio-fft;75;76;107;99;75;75;76;123;100;75 22:20:35 INFO - PROCESS | 17059 | |4;audio-oscillator;93;94;142;93;95;95;139;95;93;140 22:20:35 INFO - PROCESS | 17059 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;116;117 22:20:35 INFO - PROCESS | 17059 | |6;imaging-darkroom;147;146;145;146;145;145;144;146;145;145 22:20:35 INFO - PROCESS | 17059 | |7;imaging-desaturate;96;95;96;95;95;96;96;96;96;96 22:20:35 INFO - PROCESS | 17059 | |8;json-parse-financial;56;56;56;55;55;55;60;64;52;53 22:20:35 INFO - PROCESS | 17059 | |9;json-stringify-tinderbox;68;68;68;69;68;68;69;68;68;68 22:20:35 INFO - PROCESS | 17059 | |10;stanford-crypto-aes;81;81;82;83;82;81;83;82;83;82 22:20:35 INFO - PROCESS | 17059 | |11;stanford-crypto-ccm;120;117;125;114;123;116;125;118;113;116 22:20:35 INFO - PROCESS | 17059 | |12;stanford-crypto-pbkdf2;154;148;151;149;151;144;149;148;148;148 22:20:35 INFO - PROCESS | 17059 | |13;stanford-crypto-sha256-iterative;68;76;70;71;71;68;68;69;67;72 22:20:35 INFO - PROCESS | 17059 | __end_tp_report 22:20:35 INFO - PROCESS | 17059 | __start_cc_report 22:20:35 INFO - PROCESS | 17059 | _x_x_mozilla_cycle_collect,1056 22:20:35 INFO - PROCESS | 17059 | __end_cc_report 22:20:35 INFO - PROCESS | 17059 | __startTimestamp1457504435807__endTimestamp 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | ------- Summary: start ------- 22:20:35 INFO - PROCESS | 17059 | Number of tests: 14 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.90 (3.5%) stddev-sans-first:4.12 22:20:35 INFO - PROCESS | 17059 | Values: 110.0 111.0 106.0 110.0 111.0 111.0 99.0 112.0 111.0 110.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:152.00 stddev:21.10 (13.9%) stddev-sans-first:22.26 22:20:35 INFO - PROCESS | 17059 | Values: 156.0 128.0 152.0 176.0 129.0 152.0 151.0 136.0 191.0 128.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 22:20:35 INFO - PROCESS | 17059 | Values: 162.0 163.0 162.0 161.0 162.0 162.0 159.0 163.0 161.0 163.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#3] audio-fft Cycles:10 Average:88.10 Median:75.00 stddev:17.69 (23.6%) stddev-sans-first:18.11 22:20:35 INFO - PROCESS | 17059 | Values: 75.0 76.0 107.0 99.0 75.0 75.0 76.0 123.0 100.0 75.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.50 stddev:22.41 (24.0%) stddev-sans-first:23.11 22:20:35 INFO - PROCESS | 17059 | Values: 93.0 94.0 142.0 93.0 95.0 95.0 139.0 95.0 93.0 140.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:20:35 INFO - PROCESS | 17059 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 22:20:35 INFO - PROCESS | 17059 | Values: 147.0 146.0 145.0 146.0 145.0 145.0 144.0 146.0 145.0 145.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:20:35 INFO - PROCESS | 17059 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.46 (6.2%) stddev-sans-first:3.67 22:20:35 INFO - PROCESS | 17059 | Values: 56.0 56.0 56.0 55.0 55.0 55.0 60.0 64.0 52.0 53.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 22:20:35 INFO - PROCESS | 17059 | Values: 68.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 22:20:35 INFO - PROCESS | 17059 | Values: 81.0 81.0 82.0 83.0 82.0 81.0 83.0 82.0 83.0 82.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.00 stddev:4.37 (3.7%) stddev-sans-first:4.61 22:20:35 INFO - PROCESS | 17059 | Values: 120.0 117.0 125.0 114.0 123.0 116.0 125.0 118.0 113.0 116.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:149.00 stddev:2.62 (1.8%) stddev-sans-first:2.07 22:20:35 INFO - PROCESS | 17059 | Values: 154.0 148.0 151.0 149.0 151.0 144.0 149.0 148.0 148.0 148.0 22:20:35 INFO - PROCESS | 17059 | 22:20:35 INFO - PROCESS | 17059 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:2.67 (3.8%) stddev-sans-first:2.73 22:20:35 INFO - PROCESS | 17059 | Values: 68.0 76.0 70.0 71.0 71.0 68.0 68.0 69.0 67.0 72.0 22:20:35 INFO - PROCESS | 17059 | -------- Summary: end -------- 22:20:35 INFO - PROCESS | 17059 | 22:20:36 INFO - TEST-INFO | 17059: exit 0 22:20:36 INFO - TEST-OK | kraken | took 59994ms 22:20:36 INFO - SUITE-END | took 1172s 22:20:36 INFO - Completed test suite (00:19:33) 22:20:36 INFO - javascript benchmark 22:20:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.1134882232977, 3200.3599280143976, 3210.341879914618, 3236.4659831127865, 3268.9346213075737, 5049.267856160864, 5122.180451127821, 5159.0, 5179.972369490729, 5280.23436601693, 5137.152369858969, 5181.559567436772, 5197.116490196666, 5202.791888324463, 5222.973885130569, 4618.5381461853885, 4637.327587499802, 4665.9066818663605, 4807.927881081769, 4828.034393121372, 4687.8359257426, 4720.291956206579, 4784.3780308559835, 4795.640326975474, 4903.632227582928, 4703.647226457995, 4706.317583950308, 4720.43354797423, 4748.881277968044, 4758.000819827823, 4690.882727931795, 4703.341532185496, 4712.764361781898, 4738.170820106502, 4742.193827049376, 4650.302454631798, 4657.790399432034, 4701.247800351927, 4724.055188962221, 4727.834525791581, 5022.648414610979, 5038.042771873333, 5039.874003149914, 5053.140966035746, 5061.924071138936, 5518.862028449281, 5522.475364840334, 5525.613207075467, 5526.447355264481, 5573.693446860421, 5354.973225133849, 5510.889782204374, 5549.72251387429, 5620.1288800236025, 5622.746976386073, 5153.510416510426, 5163.7159956202395, 5165.715885626327, 5166.948330516722, 5168.793248270064, 5596.356419011784, 5597.188407680945, 5598.076317407664, 5599.132134519156, 5615.466530679579, 5272.130098533776, 5343.759530821122, 5367.919481207785, 5410.269613602113, 5460.180972854104, 5513.0, 5519.972400137974, 5520.199571062254, 5521.309836270466, 5523.033469142884, 5200.531952124251, 5496.80761173365, 5497.945020549743, 5499.670019798745, 5551.9722401387735, 5431.131019037014, 5456.508914197741, 5472.288602481652, 5479.178123281539, 5523.7238138092935, 4194.140201258735, 4196.223698615766, 4196.433481479961, 4203.201391735561, 4234.661227101825, 3764.7552909060823, 3774.037620406779, 3784.0, 3810.447485114643, 3833.2716783811543, 5123.974380128076, 5145.536901678792, 5154.871128221825, 5177.197534382177, 5195.3246078009615, 5433.755481003364, 5462.289902312674, 5478.58910581708, 5485.725713714299, 5510.448955104538, 5059.645824792303, 5141.562967147759, 5144.588432925357, 5146.073706732824, 5271.4728527147745, 4679.67242293043, 4697.412823397075, 4698.389209402756, 4727.220008698595, 4737.620990320766, 5716.57125715573, 5761.942380576224, 5781.797637082682, 5787.479126878601, 5829.621074630136, 5423.484768946943, 5429.321334833146, 5442.863928401822, 5551.916721249104, 5626.099824028136, 5754.971225144015, 5759.366469688414, 5761.308642962871, 5761.884762304814, 5810.099434587646, 5395.892082158256, 5402.918956215582, 5402.945970540244, 5408.7566059526625, 5411.107167317348, 5421.756020978986, 5459.836204913859, 5485.0, 5532.917006244829, 5552.611317207757, 5438.972805135949, 5445.482679145475, 5446.373667028342, 5453.045716999589, 5475.069238229431, 5397.8380648580605, 5428.7557059931605, 5442.374126975448, 5449.482299181572, 5479.3972663007835, 5127.615428842777, 5279.313689220377, 5303.973480132575, 5332.040232757986, 5365.731713414236, 5357.571394288526, 5376.811811586732, 5377.408485066561, 5379.811706590251, 5388.110961691434, 5269.235960785742, 5271.998320319127, 5275.076861549291, 5275.973620131875, 5318.680879147263], "unit": "score", "name": "dojo.html", "value": 5091.211011023179}, {"lowerIsBetter": false, "replicates": [518.8158203837637, 530.3132443485686, 589.254592939931, 596.076082072787, 601.6901295832647, 29256.707432925665, 29653.40693186135, 37117.28827117284, 37572.248555028884, 37722.43416348757, 41070.79464602673, 41269.0, 41399.379009314885, 41609.58390416095, 41679.583204168026, 8490.40567160299, 8635.784105397384, 8689.56552172392, 8705.0, 8711.912880871205, 8465.873011904796, 8590.87113693295, 8596.656133754643, 8606.268467180296, 8608.48349099056, 8573.485590864537, 8659.393842431033, 8871.911280887172, 8879.51162686052, 8890.155435233642, 8741.562921853914, 8802.339824513123, 8822.647094116228, 8841.071687472819, 8843.11568843117, 8625.396222264444, 8645.265152462049, 8740.781480462976, 8753.299736021103, 8765.0, 40589.0, 40905.59094409047, 40925.0, 41108.38337424941, 41134.0, 3151.936961260762, 3154.0380184043856, 3179.538966849817, 3184.8407579620925, 3241.789283696552, 29944.401111977855, 30095.849520752476, 30550.847245763853, 30696.53955190674, 31303.843480782678, 3235.336755965045, 3388.7119594834467, 3422.743294252941, 3463.1515278756615, 3496.2133519957806, 199368.0, 200035.0, 200519.0, 200825.99999999854, 201223.0, 60087.0, 60179.09731353946, 60235.397646023855, 60310.39689603048, 60323.69838150781, 68598.65700671465, 69619.65190174118, 69644.6517767408, 69682.0, 69842.0, 13747.862521374858, 13797.0, 13853.584392468241, 13943.790843137362, 13959.302034898214, 10049.497525123714, 10065.0, 10115.898841011644, 10126.746831329276, 10134.23993200513, 20536.794632053487, 20708.689369659467, 20842.687359689313, 20896.0, 21621.35135945924, 7837.882431763528, 7937.745524334995, 8001.399895007898, 8012.31895288907, 8112.75661730149, 943.3490891284991, 983.4099540275778, 1000.5147503460815, 1049.4385503755454, 1064.5050051725984, 29491.115266542038, 29563.408731825242, 29675.406491870042, 30140.397192056036, 30188.396232075676, 938.7700013496737, 1043.6242952537082, 1056.2326704035477, 1110.6945589962663, 1141.2182654881433, 13906.165630062229, 14378.784318235235, 14408.42366305357, 14569.562913112624, 14623.19572423527, 318392.0, 323996.5200695973, 324791.0, 325180.0, 325698.0, 51809.48190518122, 53475.0, 53598.0, 53608.731956339965, 53723.73138134363, 1171.7422167123389, 1242.1615409598485, 1250.5373011985623, 1324.4966912573161, 1349.102846607015, 25750.613740794277, 27595.0, 27673.58489622617, 27981.860090699418, 28025.43949121047, 40927.18145637011, 40932.0, 41224.58775412328, 41261.79369103135, 41281.380779287734, 179631.0, 180853.0, 180930.0, 180963.0, 181382.0, 28097.859510703132, 31435.84282078575, 32634.83682581667, 33014.5047824278, 33279.0, 38748.6125138745, 39310.606893931836, 39448.605513944494, 39680.2063958725, 39834.60165398309, 32962.340753184326, 33211.0, 33311.167220819676, 33477.0, 33679.0, 32989.67010329962, 33555.0, 33660.158496037795, 33727.0, 34028.48957265593, 35551.28897421985, 36032.27935441329, 36360.45459318059, 36571.634283657884, 36678.26643467169, 30637.23406914845, 32502.674973250912, 32578.185545361557, 32614.673853262113, 32630.0, 24784.50430991334, 25290.1148459803, 25702.485950281265, 25724.871375643, 27488.862555687094], "unit": "score", "name": "ext.html", "value": 17738.91797368678}, {"lowerIsBetter": false, "replicates": [359.13627725320606, 359.6888691282042, 360.4161258760808, 365.11095482500116, 369.9611540788219, 17132.229049692764, 17409.477715668534, 18482.815171848295, 18780.436586902382, 18821.717674234864, 15799.92100039501, 17610.0, 17616.0, 17620.559486012855, 17628.118594070278, 5183.6371453998145, 5489.286392768954, 5518.475744804237, 5523.917141242885, 5524.723763811813, 4016.4577781999496, 5492.0, 5857.4435428634215, 6094.573379863411, 6128.019516877301, 6052.909206361908, 6060.060690592965, 6065.272167339904, 6079.088136779496, 6095.29904061032, 5780.566457515703, 6128.632282063046, 6133.202683651141, 6147.385261473862, 6148.077788331741, 3610.963890361089, 5215.921761173586, 5381.946180538183, 5401.43358426056, 5408.756605952703, 19788.80211197884, 19981.100850461764, 20086.49783755403, 21447.5710485791, 21476.248331308485, 2239.496113374494, 2240.6639004149347, 2393.4854006388537, 2596.5066637338846, 2673.2648521656506, 12654.177478463962, 12991.285479298635, 13287.734245315136, 13471.0, 13504.189748615114, 1776.2184638758904, 1819.4814477873742, 1862.320253107606, 1893.9715904261448, 1898.3071179019557, 64775.35224647741, 65464.67267663631, 66468.33531664718, 66881.66559167222, 67106.32234194136, 9868.457234852009, 10117.949410252902, 10250.538725757358, 10253.84619230712, 10433.843492347622, 13542.187468751907, 13546.796798048037, 13628.250446225355, 13660.65848353799, 13662.726745465234, 7013.859722805515, 7134.32223938725, 7148.392386647193, 7240.058792357066, 7254.637268136677, 6737.787198304352, 6796.76211332601, 6898.1377327834025, 6913.2049814270995, 6931.930680693229, 6070.3929607038945, 6168.383161683885, 6170.784022559279, 6187.071939209155, 6203.720832562545, 1692.1454665393896, 1703.7018521758644, 1731.4936005675142, 1821.3625231169249, 1831.6519861226325, 930.63240020193, 935.7426707655313, 968.5738275158908, 1066.0991462214417, 1068.5084860963889, 16135.273912673958, 16412.75380869288, 17390.391336303168, 17613.471595852145, 18342.449726508225, 942.5146049784366, 962.1821451765943, 974.133021610767, 1015.827309357411, 1025.8461230815287, 9668.129868311886, 9962.501874906226, 9996.350237234556, 9998.150157236716, 10138.341007834615, 454534.0, 460664.9126047816, 470462.0, 473452.0, 474182.0, 69974.65012674904, 71029.0, 78786.60606697045, 80979.5951020253, 81799.5910020446, 1000.6191455791108, 1014.3913651808856, 1018.266847869518, 1044.566504900473, 1045.7124290820086, 14686.853131468975, 14864.777028344368, 15116.924415378293, 15201.543953681406, 15410.306536205673, 24766.876165619058, 32120.518192226667, 32642.878212916083, 33024.1743956403, 33410.16474588155, 46366.76816615895, 50005.74997124991, 51558.0, 51710.482895170564, 52060.21909671282, 7552.169261381354, 7661.080670319375, 7690.0, 7838.804029899298, 7881.172476890073, 9206.0, 9544.522773861418, 11892.821607675718, 11935.701607459883, 12257.0, 10606.469676516297, 10684.392416948076, 10748.89251107479, 10780.137588993019, 10792.406417646791, 10483.528241229316, 10707.19696022817, 10762.19283553721, 10885.836712449161, 10970.506327215135, 10680.465976700978, 10902.945485272523, 11029.724256893642, 11116.944415277872, 11263.549458021915, 8107.635156418093, 8181.181881811771, 8237.958810205912, 8304.83390332202, 8374.330053595575, 10461.47692615351, 11097.722556936142, 11261.099112070851, 11302.660920172408, 11362.431878406212], "unit": "score", "name": "jquery.html", "value": 8646.766675157187}, {"lowerIsBetter": false, "replicates": [1355.6475316417727, 1479.578320178749, 1485.8662720355169, 1635.5256975477112, 1778.9911050444737, 7754.340881025112, 7937.484063535866, 7950.522968621886, 7951.642176102075, 7958.721444749435, 7807.375409967203, 8008.919910800891, 8012.5593092379895, 8014.479058861185, 8016.519008859458, 2006.939791806241, 2302.5625131225097, 2310.4223944013997, 2338.8362814602983, 2375.2043065573052, 2332.4285550040263, 2342.203650758742, 2349.5418393413293, 2353.729321128075, 2359.091749676378, 2226.755056943735, 2281.863088214704, 2282.1213832674375, 2282.543491301738, 2288.25631669708, 2307.4231442139467, 2331.1025255276672, 2353.599888019041, 2355.0344358812977, 2363.7163540375263, 2338.0063473024065, 2347.5774360615083, 2351.130081869719, 2357.834951553392, 2364.4679947011955, 8106.63520141595, 8113.634886430124, 8160.102388737234, 8160.714374996906, 8172.754817355489, 4722.456917454502, 4838.129136755382, 4845.733484658343, 4849.709017458928, 4849.806007759686, 2900.361920377514, 2984.5373967035143, 3034.5903303054247, 3056.098450956973, 3065.8160510369225, 966.1739212972877, 968.3512046928574, 970.427447805798, 991.2317953586029, 991.9156871665917, 10633.096186824128, 10752.78494430115, 10796.73008174794, 10806.35161890289, 10817.0, 4369.847055353048, 4442.711223770445, 4473.619742321939, 4490.820367185342, 4563.794629241692, 9278.211352035152, 9322.394044387092, 9328.300377471716, 9335.906640933505, 9340.252779777602, 4502.707324023993, 4849.224124140121, 4850.029994001144, 4858.975705121452, 4860.270959356054, 4104.748051844216, 4152.4601801765575, 4152.979235103805, 4411.051623900877, 4492.034212644297, 3776.50905382304, 3841.9039524012123, 3844.692424606025, 3879.2241551689776, 3918.45141680165, 1221.8900298973135, 1230.8030715085542, 1240.4232032105115, 1248.843894513186, 1261.5899832554458, 1368.945242190321, 1396.385590340247, 1404.2136403613804, 1415.4621243927243, 1416.0229441685203, 7595.658195381221, 7819.569923654253, 7821.882671759929, 7822.06135263772, 7828.530288182727, 498.9675671081368, 512.5848063068926, 517.4385791416355, 521.1557277210943, 526.0347262772779, 5873.089671100986, 5933.614315069507, 5937.228160339128, 5984.31180414258, 5986.2517185351835, 9228.769280768034, 9295.860562091573, 9299.72100836976, 9429.76425589352, 9460.95269523648, 9272.30457715674, 9276.0, 9296.999999999865, 9313.44119352841, 9324.207442367338, 7402.925970740332, 7701.152873183945, 7739.458237923292, 7751.844963100706, 7761.223877612194, 7418.258174182539, 7586.468947173866, 7714.1128770192145, 7720.806979825325, 7722.266384693445, 8499.32005439551, 8504.53225072627, 8751.868721969304, 8752.956235218782, 8807.823843523222, 8729.476231426135, 8972.551372431222, 9060.728178154666, 9062.275017998676, 9068.138526839939, 6334.619922804646, 6859.314068593101, 6913.792586222421, 7018.438524918097, 7040.0847889774, 7578.280063393969, 7578.696852125853, 7612.581308028111, 7638.388928885787, 7653.961730191313, 6752.054712340375, 6883.174019117738, 6885.586864788129, 6984.3364880336285, 6999.0551275577145, 6569.835754106186, 6624.503162262753, 6756.493263005393, 6826.41975432074, 6883.965580172067, 7055.717771289296, 7141.107361579802, 7145.17830449505, 7168.89246661311, 7251.746188883364, 6427.903581446189, 6481.935180648133, 6510.641914694737, 6514.218293804774, 6520.576162549419, 6630.900536492053, 6666.033425153229, 6694.564853284521, 6723.361280678328, 6728.865422691617], "unit": "score", "name": "mootools.html", "value": 4499.1131119872025}, {"lowerIsBetter": false, "replicates": [335.30926291838813, 343.63059710810876, 345.28181382723926, 349.1707195410899, 351.59039718727684, 5708.486236238738, 5767.5962682612235, 5819.592628516, 5838.737256823442, 5853.443922827335, 5741.770329186838, 5753.223314852494, 5762.827115186541, 5763.308402991636, 5776.075827867542, 4229.830806767725, 4372.934405983897, 4397.20850246957, 4398.692091553593, 4401.581849724271, 4443.422355093833, 4515.435570553681, 4525.728456292633, 4529.932051019221, 4530.682852200347, 4425.31407631816, 4457.398251236074, 4462.0, 4465.30787727901, 4471.530489298626, 4272.9359059614135, 4318.82724691012, 4368.776742512102, 4439.4672639283335, 4468.553144685522, 3882.611738826123, 3885.902852428712, 3894.065424298148, 3897.9610203897882, 3920.8431662733456, 5509.449055094458, 5515.283013208297, 5516.558675305966, 5519.061759500854, 5522.91715624266, 5112.565431938289, 5125.4618265082, 5126.154584349669, 5128.974355128238, 5131.153359695646, 6068.726907289182, 6070.96964515179, 6072.787452439144, 6078.0, 6078.817635470943, 4334.263175260182, 4338.544452832439, 4339.71791833533, 4342.565743425664, 4342.9348559771315, 6111.480524155452, 6326.734653069405, 6392.904106438361, 6402.103705481283, 6411.0383442484, 4274.059706864485, 4330.112326972963, 4332.090261045153, 4336.891577710519, 4338.783060846945, 4374.03771170342, 4378.10248898975, 4381.518033016366, 4382.737035777864, 4389.780510974439, 5058.595312375075, 5062.240663900445, 5065.088284108896, 5065.468125846806, 5082.33929589151, 6149.846253843601, 6152.938470615326, 6160.476359509402, 6162.476189523941, 6174.44430001302, 1499.895007349475, 1527.2516466931345, 1544.5289186797909, 1548.7599422089595, 1563.1949545983828, 998.6854140945579, 1003.6035765872585, 1004.6232662751469, 1010.5553556435145, 1013.7060252526685, 5682.801101961411, 5797.623154494944, 5837.307180917572, 5881.705914704333, 5907.32065812437, 6306.369363063657, 6310.211223597051, 6319.652419116993, 6334.619922804646, 6336.04959256106, 5886.146508756292, 5888.941110588925, 5895.263092113486, 5898.3216930053595, 5903.026000709835, 3343.6154842192973, 3383.780054296463, 3391.6608339165887, 3415.55597772288, 3417.3677869594203, 6451.838704032437, 6623.503237257225, 6663.06717059612, 6690.866182676319, 6753.797386078426, 6497.090407342976, 6525.771597994048, 6526.804195874131, 6537.280899101095, 6540.149780528501, 6709.899351509634, 6720.630365329856, 6722.29415911332, 6724.125863637793, 6726.6972986216715, 6304.401081897213, 6333.20834895638, 6341.080543321101, 6349.079383489276, 6353.68231588428, 6162.938370616236, 6289.245290565162, 6291.622502649856, 6298.559100862895, 6299.275583307978, 6652.667366631552, 6713.060171576081, 6717.328267173439, 6724.663766811542, 6724.865502689821, 4318.654507639319, 4373.928387545072, 4375.868723938287, 4376.6717496187275, 4380.817179361618, 6298.653574053471, 6310.2743184534365, 6341.27075386318, 6343.11196432509, 6360.618362898241, 6161.4146656067605, 6184.226971628546, 6188.164597779242, 6190.164327815687, 6190.164327815687, 5962.433568810956, 6166.445019948226, 6166.445019948226, 6168.228971378578, 6222.875542489034, 6056.910365923749, 6074.3318234994995, 6100.0, 6110.26676798787, 6122.0, 6241.843953901189, 6245.219347581552, 6250.687465626791, 6253.749850005949, 6257.4994000480765, 5836.562257830595, 6108.419700128481, 6110.663913484801, 6111.694415279129, 6117.1741814856205], "unit": "score", "name": "prototype.html", "value": 4644.8053055729}, {"lowerIsBetter": false, "replicates": [549.9477549632784, 569.8347479231023, 623.4638211138422, 706.5937086175448, 712.836047709027, 14021.859781402183, 14109.0, 14129.999999999987, 14140.50508232212, 14144.292785360729, 13144.01419893507, 13175.604731858035, 13179.143355681874, 13241.735165296688, 13477.05660603758, 828.2711214131556, 839.0770152831897, 839.3285371702644, 839.3578912132224, 841.0244116824484, 823.5141266652673, 829.722043115557, 841.486693117198, 841.6717480182703, 842.9157084291583, 861.1130535548364, 864.1574464896738, 872.7381785464368, 872.9825403491926, 874.0254616103063, 851.8466675998318, 858.3390789092396, 866.5060915278294, 866.653338664536, 868.5874209750381, 644.7453255963868, 645.3353046362255, 646.5344951634816, 646.6411141816291, 647.1522305779397, 13996.0, 14006.0, 14093.577192684235, 14102.85897141036, 14106.647333816634, 11989.460474278678, 12157.270563766115, 12202.816957745641, 12243.93878030613, 12542.05934554912, 9761.414315141043, 9803.065628255328, 9867.90132098677, 9912.702618921443, 10025.498725063791, 3498.9650103498893, 3525.3830579648716, 3539.7876127432437, 3550.55618047744, 3607.5670919489567, 43461.13077738459, 47741.0, 48082.03835923262, 48634.756826216, 50240.74879625615, 9037.096290371042, 9065.093490650883, 9328.440293582407, 9360.157585817173, 9481.383710058963, 19101.331453399063, 19128.330508432417, 19132.330368437037, 19329.4201173965, 19366.806331936783, 6884.4148247399535, 7517.210692877278, 7889.684412623431, 8057.798555036054, 8144.0, 4339.761313127745, 4424.424824772759, 4565.315202719552, 4749.35883655702, 4822.252550854623, 3141.9057428277188, 3142.701443362877, 3147.7167054964707, 3155.873765049418, 3189.027346659291, 592.410551501259, 599.4515018757788, 607.5898768331359, 616.3589866538839, 616.4144063140035, 628.9811305660837, 638.8850006998692, 647.7668039505775, 657.385344702695, 691.7336825322287, 7591.924080759121, 7726.729564465217, 7872.606369681493, 7942.801429964297, 7966.7609971699785, 517.7230181852691, 609.929573598341, 641.6695401868042, 676.9356911093438, 695.9443244540424, 3599.352116618981, 3607.981960090183, 3641.089727568108, 3649.835757390924, 3735.6451137141926, 54522.0, 55884.0, 56421.43578564244, 56461.71769141128, 56660.0, 48901.266481002815, 49476.062872454815, 49567.75216123968, 49594.0, 50311.24533132006, 42823.0, 48318.27522587164, 50830.491695083314, 51261.74369128131, 52250.477495226085, 7991.560464174526, 8025.759227223192, 8179.509229446252, 8285.088640249447, 8326.25063744266, 34560.65439345574, 35143.0, 35480.645193548764, 36140.0, 37245.813770930974, 42341.78829105835, 43853.78073109614, 43929.78035109804, 43975.560244397144, 45000.0, 10510.737231569272, 10721.624743134265, 10911.345319280868, 11003.17476189305, 11267.380294083903, 11217.742378193441, 11350.94324528372, 11362.14783891195, 11765.294082354743, 11939.582114625946, 10242.590296388062, 10458.63394781179, 10610.522526486173, 10620.362778233331, 10939.234253602172, 10837.0, 11177.273477223955, 11201.943990279997, 11357.37534435614, 11433.714157146138, 10251.948740256252, 10604.681859544226, 10657.893421066, 10891.67324980252, 10906.127509799038, 9267.86098208514, 9280.997798972898, 9450.763730906783, 9656.613735450785, 9758.75603109928, 8589.355798315026, 9006.954965225394, 9007.697108383596, 9013.233875120426, 9495.477748723886], "unit": "score", "name": "yui.html", "value": 6223.112734736174}], "name": "dromaeo_css", "value": 6830.571866996816}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 111.0, 111.0, 99.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 152.0, 176.0, 129.0, 152.0, 151.0, 136.0, 191.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 159.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 107.0, 99.0, 75.0, 75.0, 76.0, 123.0, 100.0, 75.0], "unit": "score", "name": "audio-fft", "value": 88.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 142.0, 93.0, 95.0, 95.0, 139.0, 95.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 60.0, 64.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 83.0, 82.0, 81.0, 83.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 125.0, 114.0, 123.0, 116.0, 125.0, 118.0, 113.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [154.0, 148.0, 151.0, 149.0, 151.0, 144.0, 149.0, 148.0, 148.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [68.0, 76.0, 70.0, 71.0, 71.0, 68.0, 68.0, 69.0, 67.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1518.5}]} 22:20:37 INFO - Return code: 0 22:20:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:20:37 ERROR - # TBPL SUCCESS # 22:20:37 INFO - Running post-action listener: _resource_record_post_action 22:20:37 INFO - Running post-run listener: _resource_record_post_run 22:20:38 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534872064; Read time: 188; Write time: 550184 22:20:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240836608; Read time: 0; Write time: 324340 22:20:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293920768; Read time: 188; Write time: 225628 22:20:38 INFO - Running post-run listener: _upload_blobber_files 22:20:38 INFO - Blob upload gear active. 22:20:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:20:38 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 22:20:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:20:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:20:38 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:41 INFO - (blobuploader) - INFO - Done attempting. 22:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:41 INFO - (blobuploader) - INFO - Done attempting. 22:20:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:41 INFO - Return code: 0 22:20:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:20:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bc49bab7c07fb6bed6b4f08532f2c625808f68c6bcf2b05b89d5444f3d2b3cff6f689fa348c653b1802c44f634e7e5f3769e138d650fa794338144520e1a2399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3fbed4f7a033e585e03feb1c2c0d4fc797dc41308ab5e126a7b3230ce83657a00f5448b262b7ea33f352824ec02d8d3a9d0727042dc472ad4509fb64572a95de"} 22:20:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:20:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:20:41 INFO - Contents: 22:20:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bc49bab7c07fb6bed6b4f08532f2c625808f68c6bcf2b05b89d5444f3d2b3cff6f689fa348c653b1802c44f634e7e5f3769e138d650fa794338144520e1a2399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3fbed4f7a033e585e03feb1c2c0d4fc797dc41308ab5e126a7b3230ce83657a00f5448b262b7ea33f352824ec02d8d3a9d0727042dc472ad4509fb64572a95de"} 22:20:41 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:41 INFO - Copying logs to upload dir... 22:20:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:20:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.368274 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-08 22:20:42.471822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 22:20:42.479377) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bc49bab7c07fb6bed6b4f08532f2c625808f68c6bcf2b05b89d5444f3d2b3cff6f689fa348c653b1802c44f634e7e5f3769e138d650fa794338144520e1a2399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3fbed4f7a033e585e03feb1c2c0d4fc797dc41308ab5e126a7b3230ce83657a00f5448b262b7ea33f352824ec02d8d3a9d0727042dc472ad4509fb64572a95de"} build_url:https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010077 build_url: 'https://queue.taskcluster.net/v1/task/LyPXZvg6T8enwN3WSoUYAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bc49bab7c07fb6bed6b4f08532f2c625808f68c6bcf2b05b89d5444f3d2b3cff6f689fa348c653b1802c44f634e7e5f3769e138d650fa794338144520e1a2399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3fbed4f7a033e585e03feb1c2c0d4fc797dc41308ab5e126a7b3230ce83657a00f5448b262b7ea33f352824ec02d8d3a9d0727042dc472ad4509fb64572a95de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 22:20:42.508411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:20:42.508775) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457502683.548817-414833937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004708 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 22:20:42.558886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 22:20:42.562274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 22:20:42.858850) ========= ========= Total master_lag: 1.12 =========