builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1452123867.26 results: success (0) buildid: 20160106133012 builduid: ba04d40cb3d9415086cb1815f52693fa revision: 204cd8e5c7ac96cb6462dd0c534c9b0c409806bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.262413) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.262889) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.263209) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006429 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.295729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.296069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.398623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.398921) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.457055) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.457388) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.457783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.458091) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 15:44:27-- 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% 26.4M=0s 2016-01-06 15:44:27 (26.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.638943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.639261) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:27.688843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 15:44:27.689243) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 204cd8e5c7ac96cb6462dd0c534c9b0c409806bf --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 204cd8e5c7ac96cb6462dd0c534c9b0c409806bf --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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 15:44:27,839 truncating revision to first 12 chars 2016-01-06 15:44:27,839 Setting DEBUG logging. 2016-01-06 15:44:27,839 attempt 1/10 2016-01-06 15:44:27,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/204cd8e5c7ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 15:44:29,012 unpacking tar archive at: mozilla-inbound-204cd8e5c7ac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456713 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 15:44:29.158951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:29.159288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:29.167945) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:29.168298) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 15:44:29.169074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-06 15:44:29.169419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:44:29 INFO - MultiFileLogger online at 20160106 15:44:29 in /builds/slave/test-pgo 15:44:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:44:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:44:29 INFO - {'append_to_log': False, 15:44:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:44:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:44:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:44:29 INFO - 'branch': 'Mozilla-Inbound', 15:44:29 INFO - 'buildbot_json_path': 'buildprops.json', 15:44:29 INFO - 'config_files': ('talos/linux_config.py',), 15:44:29 INFO - 'default_actions': ('clobber', 15:44:29 INFO - 'read-buildbot-config', 15:44:29 INFO - 'download-and-extract', 15:44:29 INFO - 'populate-webroot', 15:44:29 INFO - 'create-virtualenv', 15:44:29 INFO - 'install', 15:44:29 INFO - 'run-tests'), 15:44:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:44:29 INFO - 'download_minidump_stackwalk': True, 15:44:29 INFO - 'download_symbols': 'ondemand', 15:44:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:44:29 INFO - 'tooltool.py': '/tools/tooltool.py', 15:44:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:44:29 INFO - '/tools/misc-python/virtualenv.py')}, 15:44:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:44:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:44:29 INFO - 'installer_path': 'installer.exe', 15:44:29 INFO - 'log_level': 'info', 15:44:29 INFO - 'log_name': 'talos', 15:44:29 INFO - 'log_to_console': True, 15:44:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:44:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:44:29 INFO - 'opt_config_files': (), 15:44:29 INFO - 'pip_index': False, 15:44:29 INFO - 'sps_profile': False, 15:44:29 INFO - 'sps_profile_interval': 0, 15:44:29 INFO - 'suite': 'dromaeojs-e10s', 15:44:29 INFO - 'system_bits': '32', 15:44:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:44:29 INFO - 'title': 'talos-linux64-ix-062', 15:44:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:44:29 INFO - 'use_talos_json': True, 15:44:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:44:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:44:29 INFO - 'work_dir': 'build'} 15:44:29 INFO - ##### 15:44:29 INFO - ##### Running clobber step. 15:44:29 INFO - ##### 15:44:29 INFO - Running pre-action listener: _resource_record_pre_action 15:44:29 INFO - Running main action method: clobber 15:44:29 INFO - rmtree: /builds/slave/test-pgo/build 15:44:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:44:30 INFO - Running post-action listener: _resource_record_post_action 15:44:30 INFO - ##### 15:44:30 INFO - ##### Running read-buildbot-config step. 15:44:30 INFO - ##### 15:44:30 INFO - Running pre-action listener: _resource_record_pre_action 15:44:30 INFO - Running main action method: read_buildbot_config 15:44:30 INFO - Using buildbot properties: 15:44:30 INFO - { 15:44:30 INFO - "project": "", 15:44:30 INFO - "product": "firefox", 15:44:30 INFO - "script_repo_revision": "production", 15:44:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:44:30 INFO - "repository": "", 15:44:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:44:30 INFO - "buildid": "20160106133012", 15:44:30 INFO - "pgo_build": "True", 15:44:30 INFO - "basedir": "/builds/slave/test-pgo", 15:44:30 INFO - "buildnumber": 593, 15:44:30 INFO - "slavename": "talos-linux64-ix-062", 15:44:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:44:30 INFO - "platform": "ubuntu64_hw", 15:44:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:44:30 INFO - "branch": "mozilla-inbound", 15:44:30 INFO - "repo_path": "integration/mozilla-inbound", 15:44:30 INFO - "revision": "204cd8e5c7ac96cb6462dd0c534c9b0c409806bf", 15:44:30 INFO - "stage_platform": "linux64-pgo", 15:44:30 INFO - "builduid": "ba04d40cb3d9415086cb1815f52693fa", 15:44:30 INFO - "slavebuilddir": "test" 15:44:30 INFO - } 15:44:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:44:30 INFO - Running post-action listener: _resource_record_post_action 15:44:30 INFO - ##### 15:44:30 INFO - ##### Running download-and-extract step. 15:44:30 INFO - ##### 15:44:30 INFO - Running pre-action listener: _resource_record_pre_action 15:44:30 INFO - Running main action method: download_and_extract 15:44:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:44: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')]} 15:44:30 INFO - https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/test_packages.json 15:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/test_packages.json 15:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:44:41 INFO - Downloaded 1302 bytes. 15:44:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:44:41 INFO - Using the following test package requirements: 15:44:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:44:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'jsshell-linux-x86_64.zip'], 15:44:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:44:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:44:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:44:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:44:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:44:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:41 INFO - https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:49 INFO - Downloaded 24111272 bytes. 15:44:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:44:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:44:50 INFO - Return code: 0 15:44:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:50 INFO - https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:52 INFO - Downloaded 24111272 bytes. 15:44:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:44:53 INFO - Return code: 0 15:44:53 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')]} 15:44:53 INFO - https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:44:54 INFO - Downloaded 11132285 bytes. 15:44:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:44:54 INFO - Return code: 0 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:44:56 INFO - Downloaded 55908913 bytes. 15:44:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:56 INFO - mkdir: /builds/slave/test-pgo/properties 15:44:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:44:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:44:56 INFO - Contents: 15:44:56 INFO - build_url:https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:56 INFO - Running post-action listener: _resource_record_post_action 15:44:56 INFO - Running post-action listener: set_extra_try_arguments 15:44:56 INFO - ##### 15:44:56 INFO - ##### Running populate-webroot step. 15:44:56 INFO - ##### 15:44:56 INFO - Running pre-action listener: _resource_record_pre_action 15:44:56 INFO - Running main action method: populate_webroot 15:44:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:56 INFO - '--tppagecycles', 15:44:56 INFO - '7'], 15:44:56 INFO - 'tests': ['tsvgm']}}, 15:44:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:44:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:44:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:44:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'tests': ['damp', 'tps']}, 15:44:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['damp', 'tps']}, 15:44:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:44:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:56 INFO - 'other': {'tests': ['a11yr', 15:44:56 INFO - 'ts_paint', 15:44:56 INFO - 'tpaint', 15:44:56 INFO - 'sessionrestore', 15:44:56 INFO - 'sessionrestore_no_auto_restore']}, 15:44:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['a11yr', 15:44:56 INFO - 'ts_paint', 15:44:56 INFO - 'tpaint', 15:44:56 INFO - 'sessionrestore', 15:44:56 INFO - 'sessionrestore_no_auto_restore']}, 15:44:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['a11yr', 15:44:56 INFO - 'ts_paint', 15:44:56 INFO - 'tpaint', 15:44:56 INFO - 'sessionrestore', 15:44:56 INFO - 'sessionrestore_no_auto_restore']}, 15:44:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['a11yr', 15:44:56 INFO - 'ts_paint', 15:44:56 INFO - 'tpaint', 15:44:56 INFO - 'sessionrestore', 15:44:56 INFO - 'sessionrestore_no_auto_restore']}, 15:44:56 INFO - 'other_l64': {'tests': ['a11yr', 15:44:56 INFO - 'ts_paint', 15:44:56 INFO - 'tpaint', 15:44:56 INFO - 'sessionrestore', 15:44:56 INFO - 'sessionrestore_no_auto_restore']}, 15:44:56 INFO - 'other_nol64': {'tests': ['a11yr', 15:44:56 INFO - 'ts_paint', 15:44:56 INFO - 'tpaint', 15:44:56 INFO - 'sessionrestore', 15:44:56 INFO - 'sessionrestore_no_auto_restore']}, 15:44:56 INFO - 'svgr': {'tests': ['tsvgx', 15:44:56 INFO - 'tsvgr_opacity', 15:44:56 INFO - 'tart', 15:44:56 INFO - 'tscrollx', 15:44:56 INFO - 'cart']}, 15:44:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['tsvgx', 15:44:56 INFO - 'tsvgr_opacity', 15:44:56 INFO - 'tart', 15:44:56 INFO - 'tscrollx', 15:44:56 INFO - 'cart']}, 15:44:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'tests': ['tp5o']}, 15:44:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'talos_options': ['--e10s'], 15:44:56 INFO - 'tests': ['tp5o']}, 15:44:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'talos_options': ['--xperf_path', 15:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:56 INFO - 'tests': ['tp5n']}, 15:44:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:56 INFO - 'talos_options': ['--e10s', 15:44:56 INFO - '--xperf_path', 15:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:56 INFO - 'tests': ['tp5n']}}, 15:44:56 INFO - 'talos.zip': {'path': '', 15:44:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:56 INFO - Running post-action listener: _resource_record_post_action 15:44:56 INFO - ##### 15:44:56 INFO - ##### Running create-virtualenv step. 15:44:56 INFO - ##### 15:44:56 INFO - Running pre-action listener: _resource_record_pre_action 15:44:56 INFO - Running main action method: create_virtualenv 15:44:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:44:56 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 15:44:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:44:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:56 INFO - Using real prefix '/usr' 15:44:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:44:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:59 INFO - Installing pip.................done. 15:44:59 INFO - Return code: 0 15:44:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:44:59 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')]} 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 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')]} 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:44:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:44:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:44:59 INFO - Using env: {'DISPLAY': ':0', 15:44:59 INFO - 'HOME': '/home/cltbld', 15:44:59 INFO - 'LANG': 'en_US.UTF-8', 15:44:59 INFO - 'LANGUAGE': 'en_US:en', 15:44:59 INFO - 'LOGNAME': 'cltbld', 15:44:59 INFO - 'MAIL': '/var/mail/cltbld', 15:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:59 INFO - 'MOZ_NO_REMOTE': '1', 15:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:59 INFO - 'NO_EM_RESTART': '1', 15:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:59 INFO - 'SHELL': '/bin/bash', 15:44:59 INFO - 'SHLVL': '1', 15:44:59 INFO - 'TERM': 'linux', 15:44:59 INFO - 'TMOUT': '86400', 15:44:59 INFO - 'USER': 'cltbld', 15:44:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:59 INFO - '_': '/tools/buildbot/bin/python'} 15:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:59 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 15:44:59 INFO - Cleaning up... 15:44:59 INFO - Return code: 0 15:44:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:44:59 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')]} 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 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')]} 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:44:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:44:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:44:59 INFO - Using env: {'DISPLAY': ':0', 15:44:59 INFO - 'HOME': '/home/cltbld', 15:44:59 INFO - 'LANG': 'en_US.UTF-8', 15:44:59 INFO - 'LANGUAGE': 'en_US:en', 15:44:59 INFO - 'LOGNAME': 'cltbld', 15:44:59 INFO - 'MAIL': '/var/mail/cltbld', 15:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:59 INFO - 'MOZ_NO_REMOTE': '1', 15:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:59 INFO - 'NO_EM_RESTART': '1', 15:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:59 INFO - 'SHELL': '/bin/bash', 15:44:59 INFO - 'SHLVL': '1', 15:44:59 INFO - 'TERM': 'linux', 15:44:59 INFO - 'TMOUT': '86400', 15:44:59 INFO - 'USER': 'cltbld', 15:44:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:59 INFO - '_': '/tools/buildbot/bin/python'} 15:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:59 INFO - Downloading/unpacking psutil>=0.7.1 15:44:59 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 15:44:59 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 15:44:59 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 15:44:59 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 15:44:59 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 15:44:59 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 15:45:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:45:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:45:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:01 INFO - Installing collected packages: psutil 15:45:01 INFO - Running setup.py install for psutil 15:45:01 INFO - building 'psutil._psutil_linux' extension 15:45:01 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 15:45:01 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 15:45:01 INFO - building 'psutil._psutil_posix' extension 15:45:01 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 15:45:01 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 15:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:01 INFO - Successfully installed psutil 15:45:01 INFO - Cleaning up... 15:45:01 INFO - Return code: 0 15:45:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:45:01 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')]} 15:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:01 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')]} 15:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:01 INFO - Using env: {'DISPLAY': ':0', 15:45:01 INFO - 'HOME': '/home/cltbld', 15:45:01 INFO - 'LANG': 'en_US.UTF-8', 15:45:01 INFO - 'LANGUAGE': 'en_US:en', 15:45:01 INFO - 'LOGNAME': 'cltbld', 15:45:01 INFO - 'MAIL': '/var/mail/cltbld', 15:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:01 INFO - 'MOZ_NO_REMOTE': '1', 15:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:01 INFO - 'NO_EM_RESTART': '1', 15:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:01 INFO - 'SHELL': '/bin/bash', 15:45:01 INFO - 'SHLVL': '1', 15:45:01 INFO - 'TERM': 'linux', 15:45:01 INFO - 'TMOUT': '86400', 15:45:01 INFO - 'USER': 'cltbld', 15:45:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:01 INFO - '_': '/tools/buildbot/bin/python'} 15:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:45:02 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 15:45:02 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 15:45:02 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 15:45:02 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 15:45:02 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 15:45:02 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 15:45:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:45:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:45:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:45:03 INFO - Installing collected packages: mozsystemmonitor 15:45:03 INFO - Running setup.py install for mozsystemmonitor 15:45:03 INFO - Successfully installed mozsystemmonitor 15:45:03 INFO - Cleaning up... 15:45:04 INFO - Return code: 0 15:45:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:45:04 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')]} 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 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')]} 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:04 INFO - Using env: {'DISPLAY': ':0', 15:45:04 INFO - 'HOME': '/home/cltbld', 15:45:04 INFO - 'LANG': 'en_US.UTF-8', 15:45:04 INFO - 'LANGUAGE': 'en_US:en', 15:45:04 INFO - 'LOGNAME': 'cltbld', 15:45:04 INFO - 'MAIL': '/var/mail/cltbld', 15:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:04 INFO - 'MOZ_NO_REMOTE': '1', 15:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:04 INFO - 'NO_EM_RESTART': '1', 15:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:04 INFO - 'SHELL': '/bin/bash', 15:45:04 INFO - 'SHLVL': '1', 15:45:04 INFO - 'TERM': 'linux', 15:45:04 INFO - 'TMOUT': '86400', 15:45:04 INFO - 'USER': 'cltbld', 15:45:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:04 INFO - '_': '/tools/buildbot/bin/python'} 15:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:04 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 15:45:04 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 15:45:04 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 15:45:04 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 15:45:04 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 15:45:04 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 15:45:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:05 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 15:45:05 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 15:45:05 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 15:45:05 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 15:45:05 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 15:45:05 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 15:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:45:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:06 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 15:45:06 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 15:45:06 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 15:45:06 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 15:45:06 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 15:45:06 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 15:45:06 INFO - Downloading docopt-0.6.1.tar.gz 15:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:06 INFO - Running setup.py install for blobuploader 15:45:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:45:06 INFO - Running setup.py install for requests 15:45:07 INFO - Running setup.py install for docopt 15:45:07 INFO - Successfully installed blobuploader requests docopt 15:45:07 INFO - Cleaning up... 15:45:07 INFO - Return code: 0 15:45:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45: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')]} 15:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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')]} 15:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:07 INFO - Using env: {'DISPLAY': ':0', 15:45:07 INFO - 'HOME': '/home/cltbld', 15:45:07 INFO - 'LANG': 'en_US.UTF-8', 15:45:07 INFO - 'LANGUAGE': 'en_US:en', 15:45:07 INFO - 'LOGNAME': 'cltbld', 15:45:07 INFO - 'MAIL': '/var/mail/cltbld', 15:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:07 INFO - 'MOZ_NO_REMOTE': '1', 15:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:07 INFO - 'NO_EM_RESTART': '1', 15:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:07 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:07 INFO - 'SHELL': '/bin/bash', 15:45:07 INFO - 'SHLVL': '1', 15:45:07 INFO - 'TERM': 'linux', 15:45:07 INFO - 'TMOUT': '86400', 15:45:07 INFO - 'USER': 'cltbld', 15:45:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:07 INFO - '_': '/tools/buildbot/bin/python'} 15:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:07 INFO - Running setup.py (path:/tmp/pip-hSvdnh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:07 INFO - Running setup.py (path:/tmp/pip-tHA17t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:07 INFO - Running setup.py (path:/tmp/pip-wyuSew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:07 INFO - Running setup.py (path:/tmp/pip-5kI8Rl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:07 INFO - Running setup.py (path:/tmp/pip-h_kv2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:07 INFO - Running setup.py (path:/tmp/pip-gSpzzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:07 INFO - Running setup.py (path:/tmp/pip-6c78kA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:07 INFO - Running setup.py (path:/tmp/pip-gaEap3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:08 INFO - Running setup.py (path:/tmp/pip-a2b0lu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:08 INFO - Running setup.py (path:/tmp/pip-krZN6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:08 INFO - Running setup.py (path:/tmp/pip-l9LiMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:08 INFO - Running setup.py (path:/tmp/pip-9utjcJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:08 INFO - Running setup.py (path:/tmp/pip-dRlPrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:08 INFO - Running setup.py (path:/tmp/pip-fRANIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:08 INFO - Running setup.py (path:/tmp/pip-k6xDcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:08 INFO - Running setup.py (path:/tmp/pip-YZkxlH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:08 INFO - Running setup.py (path:/tmp/pip-Exdsgx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:08 INFO - Running setup.py install for manifestparser 15:45:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:45:08 INFO - Running setup.py install for mozcrash 15:45:08 INFO - Running setup.py install for mozdebug 15:45:08 INFO - Running setup.py install for mozdevice 15:45:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Running setup.py install for mozfile 15:45:09 INFO - Running setup.py install for mozhttpd 15:45:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Running setup.py install for mozinfo 15:45:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Running setup.py install for mozInstall 15:45:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Running setup.py install for mozleak 15:45:09 INFO - Running setup.py install for mozlog 15:45:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Running setup.py install for moznetwork 15:45:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Running setup.py install for mozprocess 15:45:09 INFO - Running setup.py install for mozprofile 15:45:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:45:10 INFO - Running setup.py install for mozrunner 15:45:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:45:10 INFO - Running setup.py install for mozscreenshot 15:45:10 INFO - Running setup.py install for moztest 15:45:10 INFO - Running setup.py install for mozversion 15:45:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:45:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:10 INFO - Cleaning up... 15:45:10 INFO - Return code: 0 15:45:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:10 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')]} 15:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:10 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')]} 15:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:10 INFO - Using env: {'DISPLAY': ':0', 15:45:10 INFO - 'HOME': '/home/cltbld', 15:45:10 INFO - 'LANG': 'en_US.UTF-8', 15:45:10 INFO - 'LANGUAGE': 'en_US:en', 15:45:10 INFO - 'LOGNAME': 'cltbld', 15:45:10 INFO - 'MAIL': '/var/mail/cltbld', 15:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:10 INFO - 'MOZ_NO_REMOTE': '1', 15:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:10 INFO - 'NO_EM_RESTART': '1', 15:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:10 INFO - 'SHELL': '/bin/bash', 15:45:10 INFO - 'SHLVL': '1', 15:45:10 INFO - 'TERM': 'linux', 15:45:10 INFO - 'TMOUT': '86400', 15:45:10 INFO - 'USER': 'cltbld', 15:45:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:10 INFO - '_': '/tools/buildbot/bin/python'} 15:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:10 INFO - Running setup.py (path:/tmp/pip-7BQWAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:10 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)) 15:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:10 INFO - Running setup.py (path:/tmp/pip-sbg7e3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:10 INFO - Running setup.py (path:/tmp/pip-xarHJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:10 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)) 15:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:10 INFO - Running setup.py (path:/tmp/pip-J5WA7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 15:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:10 INFO - Running setup.py (path:/tmp/pip-Q6FKMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:11 INFO - Running setup.py (path:/tmp/pip-L2kULZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:11 INFO - Running setup.py (path:/tmp/pip-n5rWYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:11 INFO - Running setup.py (path:/tmp/pip-ey2gor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:11 INFO - Running setup.py (path:/tmp/pip-_tt5RW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:11 INFO - Running setup.py (path:/tmp/pip-L2ggOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:11 INFO - Running setup.py (path:/tmp/pip-W0eKBl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:11 INFO - Running setup.py (path:/tmp/pip-bnMEMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:11 INFO - Running setup.py (path:/tmp/pip-X6HL36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:11 INFO - Running setup.py (path:/tmp/pip-y6BX0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:11 INFO - Running setup.py (path:/tmp/pip-EQRPwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:11 INFO - Running setup.py (path:/tmp/pip-HqQtgg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:11 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)) 15:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:11 INFO - Running setup.py (path:/tmp/pip-x94OiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:11 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)) 15:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:45:11 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)) 15:45:11 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:11 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:13 INFO - Downloading blessings-1.5.1.tar.gz 15:45:13 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:45:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:13 INFO - Installing collected packages: blessings 15:45:13 INFO - Running setup.py install for blessings 15:45:13 INFO - Successfully installed blessings 15:45:13 INFO - Cleaning up... 15:45:13 INFO - Return code: 0 15:45:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:45:14 INFO - Reading from file tmpfile_stdout 15:45:14 INFO - Current package versions: 15:45:14 INFO - argparse == 1.2.1 15:45:14 INFO - blessings == 1.5.1 15:45:14 INFO - blobuploader == 1.2.4 15:45:14 INFO - docopt == 0.6.1 15:45:14 INFO - manifestparser == 1.1 15:45:14 INFO - mozInstall == 1.12 15:45:14 INFO - mozcrash == 0.16 15:45:14 INFO - mozdebug == 0.1 15:45:14 INFO - mozdevice == 0.47 15:45:14 INFO - mozfile == 1.2 15:45:14 INFO - mozhttpd == 0.7 15:45:14 INFO - mozinfo == 0.9 15:45:14 INFO - mozleak == 0.1 15:45:14 INFO - mozlog == 3.1 15:45:14 INFO - moznetwork == 0.27 15:45:14 INFO - mozprocess == 0.22 15:45:14 INFO - mozprofile == 0.28 15:45:14 INFO - mozrunner == 6.11 15:45:14 INFO - mozscreenshot == 0.1 15:45:14 INFO - mozsystemmonitor == 0.0 15:45:14 INFO - moztest == 0.7 15:45:14 INFO - mozversion == 1.4 15:45:14 INFO - psutil == 3.1.1 15:45:14 INFO - requests == 1.2.3 15:45:14 INFO - wsgiref == 0.1.2 15:45:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:14 INFO - Using env: {'DISPLAY': ':0', 15:45:14 INFO - 'HOME': '/home/cltbld', 15:45:14 INFO - 'LANG': 'en_US.UTF-8', 15:45:14 INFO - 'LANGUAGE': 'en_US:en', 15:45:14 INFO - 'LOGNAME': 'cltbld', 15:45:14 INFO - 'MAIL': '/var/mail/cltbld', 15:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:14 INFO - 'MOZ_NO_REMOTE': '1', 15:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:14 INFO - 'NO_EM_RESTART': '1', 15:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:14 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:14 INFO - 'SHELL': '/bin/bash', 15:45:14 INFO - 'SHLVL': '1', 15:45:14 INFO - 'TERM': 'linux', 15:45:14 INFO - 'TMOUT': '86400', 15:45:14 INFO - 'USER': 'cltbld', 15:45:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:14 INFO - '_': '/tools/buildbot/bin/python'} 15:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 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)) 15:45:14 INFO - Cleaning up... 15:45:14 INFO - Return code: 0 15:45:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:14 INFO - Using env: {'DISPLAY': ':0', 15:45:14 INFO - 'HOME': '/home/cltbld', 15:45:14 INFO - 'LANG': 'en_US.UTF-8', 15:45:14 INFO - 'LANGUAGE': 'en_US:en', 15:45:14 INFO - 'LOGNAME': 'cltbld', 15:45:14 INFO - 'MAIL': '/var/mail/cltbld', 15:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:14 INFO - 'MOZ_NO_REMOTE': '1', 15:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:14 INFO - 'NO_EM_RESTART': '1', 15:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:14 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:14 INFO - 'SHELL': '/bin/bash', 15:45:14 INFO - 'SHLVL': '1', 15:45:14 INFO - 'TERM': 'linux', 15:45:14 INFO - 'TMOUT': '86400', 15:45:14 INFO - 'USER': 'cltbld', 15:45:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:14 INFO - '_': '/tools/buildbot/bin/python'} 15:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:14 INFO - Downloading/unpacking jsonschema 15:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:45:16 INFO - Downloading/unpacking functools32 (from jsonschema) 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:45:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:16 INFO - warning: no files found matching '*.txt' 15:45:16 INFO - no previously-included directories found matching 'build' 15:45:16 INFO - no previously-included directories found matching 'dist' 15:45:16 INFO - no previously-included directories found matching '.git*' 15:45:16 INFO - Installing collected packages: jsonschema, functools32 15:45:16 INFO - Running setup.py install for functools32 15:45:16 INFO - warning: no files found matching '*.txt' 15:45:16 INFO - no previously-included directories found matching 'build' 15:45:16 INFO - no previously-included directories found matching 'dist' 15:45:16 INFO - no previously-included directories found matching '.git*' 15:45:16 INFO - Successfully installed jsonschema functools32 15:45:16 INFO - Cleaning up... 15:45:16 INFO - Return code: 0 15:45:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f0f9a783f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', '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 15:45:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:45:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:45:16 INFO - Using env: {'DISPLAY': ':0', 15:45:16 INFO - 'HOME': '/home/cltbld', 15:45:16 INFO - 'LANG': 'en_US.UTF-8', 15:45:16 INFO - 'LANGUAGE': 'en_US:en', 15:45:16 INFO - 'LOGNAME': 'cltbld', 15:45:16 INFO - 'MAIL': '/var/mail/cltbld', 15:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:16 INFO - 'MOZ_NO_REMOTE': '1', 15:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:16 INFO - 'NO_EM_RESTART': '1', 15:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:16 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:16 INFO - 'SHELL': '/bin/bash', 15:45:16 INFO - 'SHLVL': '1', 15:45:16 INFO - 'TERM': 'linux', 15:45:16 INFO - 'TMOUT': '86400', 15:45:16 INFO - 'USER': 'cltbld', 15:45:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:16 INFO - '_': '/tools/buildbot/bin/python'} 15:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:16 INFO - Downloading/unpacking flake8 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:45:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:45:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:45:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:45:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:45:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:45:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:19 INFO - no previously-included directories found matching 'docs/_build' 15:45:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:45:19 INFO - Running setup.py install for pep8 15:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:19 INFO - no previously-included directories found matching 'docs/_build' 15:45:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:45:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:45:19 INFO - Cleaning up... 15:45:19 INFO - Return code: 0 15:45:19 INFO - Running post-action listener: _resource_record_post_action 15:45:19 INFO - Running post-action listener: _start_resource_monitoring 15:45:19 INFO - Starting resource monitoring. 15:45:19 INFO - ##### 15:45:19 INFO - ##### Running install step. 15:45:19 INFO - ##### 15:45:19 INFO - Running pre-action listener: _resource_record_pre_action 15:45:19 INFO - Running main action method: install 15:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:45:19 INFO - Reading from file tmpfile_stdout 15:45:19 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:45:19 INFO - Reading from file tmpfile_stdout 15:45:19 INFO - Output received: 15:45:19 INFO - Usage: mozinstall [options] installer 15:45:19 INFO - Options: 15:45:19 INFO - -h, --help show this help message and exit 15:45:19 INFO - -d DEST, --destination=DEST 15:45:19 INFO - Directory to install application into. [default: 15:45:19 INFO - "/builds/slave/test-pgo"] 15:45:19 INFO - --app=APP Application being installed. [default: firefox] 15:45:19 INFO - mkdir: /builds/slave/test-pgo/build/application 15:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:45:35 INFO - Reading from file tmpfile_stdout 15:45:35 INFO - Output received: 15:45:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:45:35 INFO - Running post-action listener: _resource_record_post_action 15:45:35 INFO - ##### 15:45:35 INFO - ##### Running run-tests step. 15:45:35 INFO - ##### 15:45:35 INFO - Running pre-action listener: _resource_record_pre_action 15:45:35 INFO - Running main action method: run_tests 15:45:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:45:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:45:35 INFO - Python 2.7.3 15:45:35 INFO - Return code: 0 15:45:35 INFO - grabbing minidump binary from tooltool 15:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:35 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 0x25ef7f0>, '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 0x255b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:45:35 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 15:45:35 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 15:45:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:35 INFO - Return code: 0 15:45:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:45:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:45:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:45:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:45:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:45:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:45:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:45:36 INFO - Return code: 0 15:45:36 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:45:36 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:45:36 INFO - Using env: {'DISPLAY': ':0', 15:45:36 INFO - 'HOME': '/home/cltbld', 15:45:36 INFO - 'LANG': 'en_US.UTF-8', 15:45:36 INFO - 'LANGUAGE': 'en_US:en', 15:45:36 INFO - 'LOGNAME': 'cltbld', 15:45:36 INFO - 'MAIL': '/var/mail/cltbld', 15:45:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:45:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:36 INFO - 'MOZ_NO_REMOTE': '1', 15:45:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:36 INFO - 'NO_EM_RESTART': '1', 15:45:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:45:36 INFO - 'SHELL': '/bin/bash', 15:45:36 INFO - 'SHLVL': '1', 15:45:36 INFO - 'TERM': 'linux', 15:45:36 INFO - 'TMOUT': '86400', 15:45:36 INFO - 'USER': 'cltbld', 15:45:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265', 15:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:36 INFO - '_': '/tools/buildbot/bin/python'} 15:45:36 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:45:37 INFO - mozversion application_buildid: 20160106133012 15:45:37 INFO - mozversion application_changeset: 204cd8e5c7ac96cb6462dd0c534c9b0c409806bf 15:45:37 INFO - mozversion application_display_name: Nightly 15:45:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:37 INFO - mozversion application_name: Firefox 15:45:37 INFO - mozversion application_remotingname: firefox 15:45:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:37 INFO - mozversion application_vendor: Mozilla 15:45:37 INFO - mozversion application_version: 46.0a1 15:45:37 INFO - mozversion platform_buildid: 20160106133012 15:45:37 INFO - mozversion platform_changeset: 204cd8e5c7ac96cb6462dd0c534c9b0c409806bf 15:45:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:37 INFO - mozversion platform_version: 46.0a1 15:45:37 INFO - using testdate: 1452123937 15:45:37 INFO - actual date: 1452123937 15:45:37 INFO - starting webserver on 'localhost:56028' 15:45:37 INFO - SUITE-START | Running 3 tests 15:45:37 INFO - TEST-START | dromaeo_css 15:45:37 INFO - operating with platform_type : linux_ 15:45:37 INFO - Initialising browser for dromaeo_css test... 15:45:37 INFO - TEST-INFO | started process 24855 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBG_XkE/profile http://localhost:56028/getInfo.html) 15:45:40 INFO - PROCESS | 24855 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:45:41 INFO - PROCESS | 24855 | __metrics Screen width/height:1600/1200 15:45:41 INFO - PROCESS | 24855 | colorDepth:24 15:45:41 INFO - PROCESS | 24855 | Browser inner width/height: 1024/697 15:45:41 INFO - PROCESS | 24855 | __metrics 15:45:41 INFO - PROCESS | 24855 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:45:42 INFO - TEST-INFO | 24855: exit 0 15:45:42 INFO - Browser initialized. 15:45:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:42 INFO - TEST-INFO | started process 24989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBG_XkE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:54 INFO - PROCESS | 24989 | RSS: Main: 150663168 15:45:54 INFO - PROCESS | 24989 | 15:46:43 INFO - PROCESS | 24989 | 1452124003702 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] 15:48:52 INFO - PROCESS | 24989 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56028/tests/dromaeo/cssquery-ext.html) 15:48:54 INFO - PROCESS | 24989 | RSS: Main: 158601216 15:48:54 INFO - PROCESS | 24989 | 15:51:56 INFO - PROCESS | 24989 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-ext.html (next: http://localhost:56028/tests/dromaeo/cssquery-jquery.html) 15:51:56 INFO - PROCESS | 24989 | RSS: Main: 152862720 15:51:56 INFO - PROCESS | 24989 | 15:54:58 INFO - PROCESS | 24989 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56028/tests/dromaeo/cssquery-mootools.html) 15:54:59 INFO - PROCESS | 24989 | RSS: Main: 153669632 15:54:59 INFO - PROCESS | 24989 | 15:58:00 INFO - PROCESS | 24989 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56028/tests/dromaeo/cssquery-prototype.html) 15:58:01 INFO - PROCESS | 24989 | RSS: Main: 152842240 15:58:01 INFO - PROCESS | 24989 | 16:01:03 INFO - PROCESS | 24989 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56028/tests/dromaeo/cssquery-yui.html) 16:01:04 INFO - PROCESS | 24989 | RSS: Main: 153788416 16:01:04 INFO - PROCESS | 24989 | 16:04:06 INFO - PROCESS | 24989 | Cycle 1(1): loaded http://localhost:56028/tests/dromaeo/cssquery-yui.html (next: http://localhost:56028/tests/dromaeo/cssquery-dojo.html) 16:04:07 INFO - PROCESS | 24989 | RSS: Main: 155459584 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | __start_tp_report 16:04:07 INFO - PROCESS | 24989 | _x_x_mozilla_page_load 16:04:07 INFO - PROCESS | 24989 | _x_x_mozilla_page_load_details 16:04:07 INFO - PROCESS | 24989 | |i|pagename|runs| 16:04:07 INFO - PROCESS | 24989 | |0;dojo.html;3094.690530946905;3152.5744024556693;3175.793573417729;3198.5332582691053;3205.903822885314;5269.077911365515;5368.141097424413;5451.482109199625;5467.535259502947;5472.288602481677;5336.866578335544;5344.171653393721;5400.351957765064;5531.225628412026;5534.667919924807;4919.508049195088;4990.176620857555;5059.418166910816;5077.441481437039;5090.618203634724;5000.599952003831;5049.141645920203;5093.032323858455;5111.361079865017;5116.718580478072;4871.732054736988;4934.851954441372;5016.272640467148;5026.969471258401;5147.639665223436;4810.446798618169;4880.194767863299;4883.267509873512;4912.680675756064;4913.778879950411;4875.561199492063;4892.07050660377;4893.119238537062;4916.041371932474;4923.729194894279;5100.821471248489;5162.5095615916425;5170.663906846043;5222.138347172712;5279.340082489689;5870.26621672291;5878.735456904449;5878.853028674274;5884.382139875294;5890.882182356372;5907.6750778707155;5942.227510423617;5951.553633477463;5956.315023772278;5959.255093113361;5271.130263506517;5407.567394608462;5413.945860541423;5480.314960629921;5502.422245664227;5866.765329386777;5876.353601103875;5892.970535147297;5893.116032595145;5921.911171332434;5611.186377975252;5664.51851592611;5669.31968163823;5675.858103547362;5694.06048002075;5755.8561035974435;5807.88384232313;5830.650160990269;5871.794487192928;5879.941200588025;5806.79676211339;5816.5055970243;5840.065589505659;5842.240508733922;5860.384659610765;5845.976954033027;5857.88284234313;5868.295804503487;5873.970630146822;5875.676837773964;4489.932651010237;4494.325851122358;4511.842085526991;4517.051419201939;4523.117991991596;3969.702272329587;3993.1414745829206;3995.600439955981;4014.1570270243574;4027.959720402817;5435.456454354612;5504.284443022381;5519.227308176858;5521.171824226318;5532.17017447378;5735.2257445245195;5848.298204215436;5872.588918775645;5875.851356195491;5898.793542226002;5464.153056276284;5483.616146869761;5493.972530137324;5498.890022199534;5513.2005859151;4909.214525675875;4935.87660308488;4936.3829521309835;4936.753162341868;4962.925556116661;5858.8242352729485;5910.172575839386;5972.223610930551;5992.64044157352;6084.6349219046115;5697;5713.885722285448;5781.988152073286;5783.132530120515;5791.449812267828;5893.793717219876;5920.733566989582;5935.228420305332;5953.672548009901;5965.6718880461995;5600.467955544217;5666.490015898424;5700.401457846866;5800.970995144998;5856.180134781049;5915.556333275108;5943.58394912352;5960.403959604005;5974.372690867396;5978.4021597839865;5609.663420194802;5779.826605201851;5820.621659592113;5821.912671310019;5845.824625261249;5664.291963504562;5723.627964182315;5833.358330583717;5850.0932355484965;5899.734511946886;5583.916241256466;5601.29983752031;5639.887202256014;5651.124075768263;5657.745401456862;5672.914906276326;5682.346530149086;5732.59871808986;5765.827025189251;5771.134329850556;5671.631343962629;5676.375598684059;5755.625884317506;5806.5645076618575;5807.535397168301 16:04:07 INFO - PROCESS | 24989 | |1;ext.html;527.2039220776626;531.4526038180674;556.7355506134584;560.5487582496094;583.932847722512;33719.494207586875;34570;34604.13489662756;34653.61385544579;34785.65214347856;37283.25433491328;38030.23939521208;38061.80969095157;38105.42841857374;38119;8387.538685372318;8451.661933522682;8514.191151840565;8515.276201522878;8551.914480855174;8290.502569845798;8379.748607541784;8393.916060839374;8556.572171391406;8594.398392112555;8582.656693732244;8597.226249637532;8602.526861022641;8647.264982476498;8664;8537.701180458685;8587.742367728979;8600.397972141953;8600.913990860105;8611.655533778641;8335.83328333436;8466.83066338676;8482.53346065966;8550.74347769568;8588.269997050258;38256.23487530234;38342.80828595867;38723;38797.224055519015;38843.8346849595;3082.8458577071056;3101.348716769481;3193.552902593639;3206.6633003534757;3568.6966607838103;29456.41087178266;29537.852310738308;30079.849600751855;30449.23876903073;30843.537346939815;3686.7787932724123;3700.6669399753882;3729.8881033569037;3762.7930463824478;3864.401017842239;249563;251286;251455;251732;252069.7396513024;49789;50693;57660.423395766345;58683.70658146682;58834;56420.153697694564;56524.717376413675;56620.71689641525;56765.71617141888;56840.71579642075;15610.14144222056;15770.526884193492;15836.337184595683;15850;15859.444919427764;11964.162508624488;12027.173614200656;12035.819462708067;12043.638690839289;12136.757264854654;18765.155567999198;18812.777169484212;18859.717104243446;18913.43259702211;19048.904755476135;7499.475246634073;7664.4634875559295;7684.731034413769;7809.45333826638;7896.60516974149;908.8000639859221;979.6228452045871;1030.2427715629008;1063.9734006649896;1073.0235485707967;26472.205833825017;26874.731252687223;26975.730242697322;27252;27261.72738272592;1029.4235228272191;1035.3115178406276;1060.4962642744788;1080.2978064258139;1085.3270971997413;15039.774403383957;15043.548693539211;15142.772858407132;15327.31027103783;15361.462348817739;284498;287728;288286;288784;289037;48558;48620.756896215295;48823;49013.50986490161;49121.263181052316;1306.8105124756858;1336.0714303559128;1337.806018127366;1339.1094921877038;1340.9798853017212;27825.721742782313;28926.421471570873;29012.12963611095;29174.124776256747;29439.11682649524;44810.327845081694;45617.77191114023;46002.769986149855;46123;46130;288399;290074;290976;291816;293260.8706521162;32834.01497955065;43199.35200971925;43308.566914330455;43385.566144338154;43534.78232608944;39021;39220.41169382405;39225.411618826314;40393.39409908913;40937.795311023256;32857.67142328642;33493.83253083817;34014;34022.14944626404;34220;37603.81198093992;38536.775431094684;39381.409278860265;40512.3923141159;40530.9867253321;37605.435918460695;38318.425223622224;38396.23207535778;38615;38816.417753734284;28859.567106493;29172.416551669274;34078.65921340854;36234;36874.631253688196;24315.635265471385;25035.248942531754;26791.464170716867;27257.86371068211;28379.716202837706 16:04:07 INFO - PROCESS | 24989 | |2;jquery.html;340.40429248814576;344.06071425009725;344.5658470327387;345.7441493294961;346.02076124567463;11218.887811121886;11713.472893719781;14574.052686575378;15698.607534811621;16435.178241087942;17439.91280043598;17442.12789360533;17565.560860978483;17623.383181588648;17750.201240944156;5712.257406537145;5822.475977162055;5878.2064421303;5886.676232807194;5896.35140134587;5755.568332375088;5858.518233551336;5886.999210134266;5953.642781433106;5960.463558279754;5779.162021506879;5793.4206579341935;5800.042992906166;6100.847478813021;6313.684315784215;6075.9696201519155;6196.752129914798;6202.2247219097835;6265.655388953605;6588.209414870246;6348.523860710465;6393.776217832354;6430.871382572369;6438.645874476902;6439.517036222255;22287;22832.77167228323;23382.18162364326;23447.882760586257;23561.88219058911;2012.9295474658318;2049.3237231713647;2232.7767223277706;2263.569921714869;2299.3906614747107;13146.671333216651;14262.85737142636;14308.499202527966;14453.566393008226;14549.418023279057;1856.8885866847897;1875.5686192175876;1888.792232854385;1911.6845720456108;1919.4145785535407;57564.136537952385;57867;59009;64152.679236603515;71387;14818.925905370405;15211.554902284266;15222.391104355924;15249.771253431207;15298;22997.770022299897;23464.413389665395;23707.170249041545;23754.406139846298;23902.282931512083;8804.339674524435;8881.822363552692;8963.103689631114;9029.09709029105;9044.366894317334;7644.426667999811;7665.156832748393;7690.307872291409;7729.149793522708;7752;7846.921530784619;7866.505363980826;7889.566073865878;7937.047554293522;7958.801029974297;1837.4303965770655;3162.905112846618;3216.388886111631;3217.951730724041;3264.657210992859;825.6367198432671;918.6233644205844;922.2852289475576;927.9536023198813;980.7204946590188;16103;16109.355625774837;16277.430289940032;16442;16590.585235369213;857.0101532729707;878.0604752914448;889.4352086425038;928.1275600935099;996.1881066930429;8968.757810547364;9362.719118426457;9366.95316523413;9422.340436169403;9587.280953928483;503870;507247;537639;566450;580436;72578;80155;80731;81138.18861811307;83260;1153.2158132469833;1155.2837240910521;1184.490669012333;1204.3436327201696;1228.969275768113;15718.528444146694;16013.359465621244;16070.758938615696;16100;16390.508284751475;34918;34949.47575786315;35594.46608300826;36125.81937090298;36536.26927461489;46116.07767844691;47556.28665570088;49024.26463602977;49383;49413.50586494233;9165.587548560197;9566.426014439156;9602.66390676351;9766.951165244129;9783.266255031043;11467.770644586895;11543.249688770204;11548.307101573933;12431.689207769878;17396.217170227115;13170.868291317347;14065.296735162996;14494.188226471691;15158.621034474227;15470.303836327617;14632;14815.111093334435;14996.100233985995;15323.46367877119;15394.15332156742;15039.398424062914;15364.923175384052;15365.923170384523;15495.690086198438;15551.14468704187;9044.457332560067;9092.727218183465;9554.61781528731;9641.325107242426;9679.467629280176;10112.898871011195;13260.801087983495;13761.931190343985;13962.301884905512;14007.229602371968 16:04:07 INFO - PROCESS | 24989 | |3;mootools.html;1464.5899148238493;1467.2223721427645;1617.5066604685567;1752.0101142854294;1787.2314904591021;6798.388145066943;6876.724931002766;7512.323890849822;7573.129090154634;7639.083310002808;7169.42644588433;7317.4511911606705;7385.150707668619;7388.224236455162;7418.443616728753;2232.720909886264;2275.408393817611;2276.4764104256033;2281.851679640826;2288.9084436622516;2233.419310979141;2267.716535433071;2273.499830037389;2283.4291427143216;2287.142321629389;2251.324602619216;2253.5830871288863;2255.424866659008;2274.101729816721;2276.9886150569305;2226.443389152712;2235.3964429604;2250.606143924823;2271.3867255840996;2282.6005449046434;2248.651459023854;2253.853499522526;2263.343630347197;2271.7841805028497;2279.954400911989;7598.582077985764;7624.961875190644;7626.237376262385;7638.5798781067015;7656.808579785495;4485.461744590637;4549.181147393468;4622.2835460503675;4632.791524381411;4638.8608341749805;2996.16107489901;3047.0401823425773;3098.581691471645;3127.2807254331633;3159.526071089332;917.6146018672107;920.6823645842173;927.2535608834885;980.3578655980344;990.173205373514;10299.382037077725;10326.9483652582;10455.68632941013;10484.423356715377;10486.842697359545;4099.446574712376;4135.524414692289;4136.9793151034655;4173.040200753783;4194.706370554093;8878.245349145394;8941.061188575106;8950.239229665422;8998.235150012191;8999.05509921462;4647.674662773574;4654.394928659252;4657.301404789308;4658.534146585314;4659.4175728034;3758.473813666089;3853.479780229633;4093;4205.558416366299;4246.447961765012;3503.3168532136497;3508.7193024557973;3511.894643160709;3519.7008254298157;3546.5034895114704;1095.6822521468684;1097.1771171621283;1101.1686176936362;1111.6887271563976;1117.0337657925998;1295.5400832704443;1303.426492343366;1304.8695130487065;1328.2960031183488;1335.6460537957448;6975.162980442379;7056.682449289794;7188.82027949295;7204.747833825896;7207.990881276625;461.05943874496324;464.7885212228428;467.4460763994677;470.1396444506545;471.1166562694947;5569.359523654832;5626.634268772516;5644.040513112781;5649.096144616841;5650.3219613646625;8818.382713210141;8902.59938302765;9133.49765762876;9183.540822958825;9266.860997085048;9004;9196.494192819326;9208.309376796768;9227.815443691088;9231.76920576991;7097.787066388017;7131.607761573059;7171.462140339496;7193.424526038009;7218.27817218274;6981.860362792817;7003.229644739176;7027.402670773042;7029.683664235019;7035.085438892911;7913.604319783873;8101.230383113595;8167.877481837896;8234.423590348619;8247.134050924567;8171.877421838558;8397.244248017707;8414.368922330972;8453.535055571756;8478.957605211934;6443.0335449682925;6527.869442611216;6584;6931.6880740367815;6952.791416257521;7140.39306658919;7160.856782864418;7193.676284567312;7209.170945341353;7211.783646490614;6590.209174898851;6749.898751518829;6777.796666100025;6850.588964662136;7026.262242464672;6694.163229596301;6754.86490270182;6784.423324017316;6831.965840170966;6891.104156459829;6772.898406523807;6816.522843400914;6893.724251030103;6897.206821215424;7019.719211231493;6358.523110766619;6444.8388790280615;6457.257415397289;6459.095726598186;6481.967590162019;6477.255115661759;6496.123023391781;6498;6499.772507962199;6500.3174666659315 16:04:07 INFO - PROCESS | 24989 | |4;prototype.html;332.49128832885685;334.954781104551;335.11028220075707;343.22773759042155;348.030734404683;6182.536309776773;6182.845428864275;6225.159603453532;6276.1527193828815;6380.680965951707;6184.350643182469;6215.036669316252;6227.629921417292;6241.407066328703;6277.717502712378;4679.759863636139;4683.8360657377;4686.367340409035;4687.578117969382;4693.624510039189;4708.7645617719145;4709.387779588666;4715.08055929094;4738.028704115665;4740.71555706657;4516.593506584407;4517.593416592506;4644.140833945714;4657.627389808824;4661.86014419568;4619.491855895849;4628.097520983392;4642.3500709900645;4643.16423043852;4654.418197725285;4012.8996775080564;4020.2562525932794;4027.7180597358197;4035.677145828356;4049.1699201663587;5872;5923.970380148115;5925.140854576105;5938;5959.0763431668165;5311.548518375943;5449.64577302474;5462.453754624546;5540.695261760601;5544.972275138599;6585.440237579812;6590.736370545173;6608.9339106608795;6609;6613.669316534154;4476.37330773692;4485.237509623372;4485.304777759453;4501.099780044005;4517.525659805706;6776.966115169442;6827.965860170667;6858.211305699809;6863.691133898987;6873.621950792704;4605.930911036337;4612.285095810088;4633.050224703928;4634.119517291704;4647.209974304376;4643.303504474288;4657.580817726353;4670.462896766848;4690.249560070372;4694.953050469451;5451;5465.9180112298345;5467.398586155519;5476.890462190734;5479.616426850162;6487.091807147003;6647.534672572873;6660.333966603301;6692.732290708317;6696.129503164558;1646.514278287908;1646.9588260293588;1647.7940257467817;1656.2215758593443;1658.0300524193242;1083.344576531203;1098.0831006109988;1100.4112799652148;1102.8089663163923;1126.14975693351;6300.054991751274;6317.9684101580115;6322.810315690536;6331.525135614847;6339;6827.761028364082;6851.725930962705;6853.862922741518;6886.655667216719;6902.413294869892;6094.268687757498;6323.27282362525;6325.114483972247;6329.050642403677;6351.110844481776;3717.7211709121925;3724.7578907370935;3730.1047748540695;3743.5882052974152;3761.661450469416;7183.102112235971;7187.137543494814;7204.135503739585;7218.927810721931;7227.349538541556;6897.55165914214;6999.580025198505;7018.719251229996;7044.894326585106;7074.893876591856;7120.181179164462;7167.104111986002;7204.279572042754;7221.602811845399;7222.927770722331;6886.10480637534;6939.201991770809;6939.895901561582;6945.444364450933;6959.61722105289;6757.763478278237;6809.4211991979255;6865.141857267841;6869.519133660596;6871.828204294932;7189.892151617834;7190.245024272376;7203;7235.3488186063505;7255.963720181366;4666.580007799314;4688.460827004938;4698.671093023456;4700.2949557566635;4711.78796954131;6656.7004484797335;6898.379145876896;6929.618870962146;6969.616671083139;6980.127484064492;6721.294264102199;6752.291009444134;6765.2896445872475;6782.932170678428;6798.218204906301;6610.10763546915;6729;6744.190697116182;6767.39093481589;6784.118064651564;6527.086207930988;6578.868422631616;6588.538802283794;6598.868022639616;6604.273529911802;6745.561538499982;6751.72993080291;6766.661666916536;6768.221654509597;6769.729210831709;6386.680665966776;6530.967345163243;6582.506312026521;6593.868122637425;6594.406503414716 16:04:07 INFO - PROCESS | 24989 | |5;yui.html;724.2250791652932;734.5959722152814;745.79490640074;824.7443292579301;836.1387770596284;12604.684882877933;12743.936280318609;12813.167144135625;12842.807357889638;12913;12446.751064978695;12515.749685006294;12559.372031398416;12559.99520038397;12587.181833180837;800.3197282310034;800.8598495263305;817.3951276055735;823.5840900345318;825.7564018614523;792.2473650032464;802.7391097893208;803.5459965119688;804.5936801915054;806.2501873257868;846.2341580869293;846.3398549131687;857.2070834478114;858.0175698824874;858.8539948208788;841.6843683618642;846.5174850335311;847.5211505499373;849.2781136034383;852.2074470742269;624.082598580091;626.9122322874802;628.3779058731868;628.6353914729445;630.782380078872;13115.737685246337;13511.189328640216;13512.324383780771;13537.729245415136;13539.729205415935;11418.771624567462;11602.6519204424;11710.941445292805;12385.442655080453;12442.502299907992;9863;10479.895201047968;10597.84103238452;10673.359598424042;10692.144628429707;3580.7825339384735;3632.909177270589;3642.8360723767228;3660.4509323601405;3769.5288088988877;49746.2538061933;51594.74202628963;51724.824927530324;51996.74001630006;52131.73934130305;9233.907660923305;9267.304952128618;9282.574537064587;9391.483468409304;9396.48319342429;17565.297388104587;17579.12104394775;17605.471835844946;17613;17663.470095897144;7190.9280907191305;7210.567365958059;7218.917162425678;7313.561186328731;7331.032112490937;3933.3903244997073;4057.797110144481;4057.9797101014306;4098.098418347959;4106.137711080706;3131.9843400783307;3135.8745650173737;3155.857986390618;3156.100511354253;3162.2726772841916;563.0737436916249;566.5127989928658;567.5487987050304;578.0375674501992;580.6516090345843;598.2491972574478;627.3412916437723;627.733213384319;629.9401556852092;638.296817931781;7886.290233878978;8082.0301563811545;8092.959535202404;8167.346612271004;8214.096449390563;581.4040608376448;628.9528285378615;670.3844328429042;676.6346173066489;684.815099923018;3809.276237514863;3954.703397245218;3986.7209295349626;4006.4591280177387;4047.6964227683043;54441;61117;61307;61332;62076;46995;47590.524094759305;47607.28589071167;47732.7613361931;48047.279290810664;44993.775031124635;49185.01629967381;49226.26160607594;49482.752586236835;49827.75086124546;8488.702895398632;8802.779930501789;9254.4910029949;9273.119053689888;9290.58192381331;35347.82326088456;35559.64440355667;36094;36137;36769;42567.712516774256;47368.28947565858;48022.27966580574;48034;48700.269495958295;10741.570337186426;10776.137908967106;10972.286801357886;11045;11134.832977505506;11258.887411125785;11281.887181128412;11503.53985840557;11555.422228888354;11722.58970936013;10663.4135122569;10750.8387374191;10756.354618722902;10993.120550355792;11445.484953177294;10790.406527640742;11044.33733975964;11082.833757493805;11113.166512511432;11437.734364495469;9901.603935842486;10085.949570252102;10244.129249013618;10340.069393754598;10532;9813.362131461432;9818.30504420293;9842.45866477322;10158.542865570918;10291.845622315821;8785.692500762443;8867.73396798097;9261.212796912338;9542.570584323861;9576.808463830825 16:04:07 INFO - PROCESS | 24989 | __end_tp_report 16:04:07 INFO - PROCESS | 24989 | __start_cc_report 16:04:07 INFO - PROCESS | 24989 | _x_x_mozilla_cycle_collect,327 16:04:07 INFO - PROCESS | 24989 | __end_cc_report 16:04:07 INFO - PROCESS | 24989 | __startTimestamp1452125047090__endTimestamp 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | ------- Summary: start ------- 16:04:07 INFO - PROCESS | 24989 | Number of tests: 6 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | [#0] dojo.html Cycles:165 Average:5414.14 Median:5657.75 stddev:614.19 (10.9%) stddev-sans-first:588.51 16:04:07 INFO - PROCESS | 24989 | Values: 3094.7 3152.6 3175.8 3198.5 3205.9 5269.1 5368.1 5451.5 5467.5 5472.3 5336.9 5344.2 5400.4 5531.2 5534.7 4919.5 4990.2 5059.4 5077.4 5090.6 5000.6 5049.1 5093.0 5111.4 5116.7 4871.7 4934.9 5016.3 5027.0 5147.6 4810.4 4880.2 4883.3 4912.7 4913.8 4875.6 4892.1 4893.1 4916.0 4923.7 5100.8 5162.5 5170.7 5222.1 5279.3 5870.3 5878.7 5878.9 5884.4 5890.9 5907.7 5942.2 5951.6 5956.3 5959.3 5271.1 5407.6 5413.9 5480.3 5502.4 5866.8 5876.4 5893.0 5893.1 5921.9 5611.2 5664.5 5669.3 5675.9 5694.1 5755.9 5807.9 5830.7 5871.8 5879.9 5806.8 5816.5 5840.1 5842.2 5860.4 5846.0 5857.9 5868.3 5874.0 5875.7 4489.9 4494.3 4511.8 4517.1 4523.1 3969.7 3993.1 3995.6 4014.2 4028.0 5435.5 5504.3 5519.2 5521.2 5532.2 5735.2 5848.3 5872.6 5875.9 5898.8 5464.2 5483.6 5494.0 5498.9 5513.2 4909.2 4935.9 4936.4 4936.8 4962.9 5858.8 5910.2 5972.2 5992.6 6084.6 5697.0 5713.9 5782.0 5783.1 5791.4 5893.8 5920.7 5935.2 5953.7 5965.7 5600.5 5666.5 5700.4 5801.0 5856.2 5915.6 5943.6 5960.4 5974.4 5978.4 5609.7 5779.8 5820.6 5821.9 5845.8 5664.3 5723.6 5833.4 5850.1 5899.7 5583.9 5601.3 5639.9 5651.1 5657.7 5672.9 5682.3 5732.6 5765.8 5771.1 5671.6 5676.4 5755.6 5806.6 5807.5 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | [#1] ext.html Cycles:180 Average:44665.77 Median:20491.96 stddev:72212.69 (352.4%) stddev-sans-first:72339.22 16:04:07 INFO - PROCESS | 24989 | Values: 527.2 531.5 556.7 560.5 583.9 33719.5 34570.0 34604.1 34653.6 34785.7 37283.3 38030.2 38061.8 38105.4 38119.0 8387.5 8451.7 8514.2 8515.3 8551.9 8290.5 8379.7 8393.9 8556.6 8594.4 8582.7 8597.2 8602.5 8647.3 8664.0 8537.7 8587.7 8600.4 8600.9 8611.7 8335.8 8466.8 8482.5 8550.7 8588.3 38256.2 38342.8 38723.0 38797.2 38843.8 3082.8 3101.3 3193.6 3206.7 3568.7 29456.4 29537.9 30079.8 30449.2 30843.5 3686.8 3700.7 3729.9 3762.8 3864.4 249563.0 251286.0 251455.0 251732.0 252069.7 49789.0 50693.0 57660.4 58683.7 58834.0 56420.2 56524.7 56620.7 56765.7 56840.7 15610.1 15770.5 15836.3 15850.0 15859.4 11964.2 12027.2 12035.8 12043.6 12136.8 18765.2 18812.8 18859.7 18913.4 19048.9 7499.5 7664.5 7684.7 7809.5 7896.6 908.8 979.6 1030.2 1064.0 1073.0 26472.2 26874.7 26975.7 27252.0 27261.7 1029.4 1035.3 1060.5 1080.3 1085.3 15039.8 15043.5 15142.8 15327.3 15361.5 284498.0 287728.0 288286.0 288784.0 289037.0 48558.0 48620.8 48823.0 49013.5 49121.3 1306.8 1336.1 1337.8 1339.1 1341.0 27825.7 28926.4 29012.1 29174.1 29439.1 44810.3 45617.8 46002.8 46123.0 46130.0 288399.0 290074.0 290976.0 291816.0 293260.9 32834.0 43199.4 43308.6 43385.6 43534.8 39021.0 39220.4 39225.4 40393.4 40937.8 32857.7 33493.8 34014.0 34022.1 34220.0 37603.8 38536.8 39381.4 40512.4 40531.0 37605.4 38318.4 38396.2 38615.0 38816.4 28859.6 29172.4 34078.7 36234.0 36874.6 24315.6 25035.2 26791.5 27257.9 28379.7 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | [#2] jquery.html Cycles:180 Average:29688.53 Median:34933.74 stddev:88110.43 (252.2%) stddev-sans-first:88330.05 16:04:07 INFO - PROCESS | 24989 | Values: 340.4 344.1 344.6 345.7 346.0 11218.9 11713.5 14574.1 15698.6 16435.2 17439.9 17442.1 17565.6 17623.4 17750.2 5712.3 5822.5 5878.2 5886.7 5896.4 5755.6 5858.5 5887.0 5953.6 5960.5 5779.2 5793.4 5800.0 6100.8 6313.7 6076.0 6196.8 6202.2 6265.7 6588.2 6348.5 6393.8 6430.9 6438.6 6439.5 22287.0 22832.8 23382.2 23447.9 23561.9 2012.9 2049.3 2232.8 2263.6 2299.4 13146.7 14262.9 14308.5 14453.6 14549.4 1856.9 1875.6 1888.8 1911.7 1919.4 57564.1 57867.0 59009.0 64152.7 71387.0 14818.9 15211.6 15222.4 15249.8 15298.0 22997.8 23464.4 23707.2 23754.4 23902.3 8804.3 8881.8 8963.1 9029.1 9044.4 7644.4 7665.2 7690.3 7729.1 7752.0 7846.9 7866.5 7889.6 7937.0 7958.8 1837.4 3162.9 3216.4 3218.0 3264.7 825.6 918.6 922.3 928.0 980.7 16103.0 16109.4 16277.4 16442.0 16590.6 857.0 878.1 889.4 928.1 996.2 8968.8 9362.7 9367.0 9422.3 9587.3 503870.0 507247.0 537639.0 566450.0 580436.0 72578.0 80155.0 80731.0 81138.2 83260.0 1153.2 1155.3 1184.5 1204.3 1229.0 15718.5 16013.4 16070.8 16100.0 16390.5 34918.0 34949.5 35594.5 36125.8 36536.3 46116.1 47556.3 49024.3 49383.0 49413.5 9165.6 9566.4 9602.7 9767.0 9783.3 11467.8 11543.2 11548.3 12431.7 17396.2 13170.9 14065.3 14494.2 15158.6 15470.3 14632.0 14815.1 14996.1 15323.5 15394.2 15039.4 15364.9 15365.9 15495.7 15551.1 9044.5 9092.7 9554.6 9641.3 9679.5 10112.9 13260.8 13761.9 13962.3 14007.2 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | [#3] mootools.html Cycles:180 Average:5315.59 Median:6479.61 stddev:2758.49 (42.6%) stddev-sans-first:2751.04 16:04:07 INFO - PROCESS | 24989 | Values: 1464.6 1467.2 1617.5 1752.0 1787.2 6798.4 6876.7 7512.3 7573.1 7639.1 7169.4 7317.5 7385.2 7388.2 7418.4 2232.7 2275.4 2276.5 2281.9 2288.9 2233.4 2267.7 2273.5 2283.4 2287.1 2251.3 2253.6 2255.4 2274.1 2277.0 2226.4 2235.4 2250.6 2271.4 2282.6 2248.7 2253.9 2263.3 2271.8 2280.0 7598.6 7625.0 7626.2 7638.6 7656.8 4485.5 4549.2 4622.3 4632.8 4638.9 2996.2 3047.0 3098.6 3127.3 3159.5 917.6 920.7 927.3 980.4 990.2 10299.4 10326.9 10455.7 10484.4 10486.8 4099.4 4135.5 4137.0 4173.0 4194.7 8878.2 8941.1 8950.2 8998.2 8999.1 4647.7 4654.4 4657.3 4658.5 4659.4 3758.5 3853.5 4093.0 4205.6 4246.4 3503.3 3508.7 3511.9 3519.7 3546.5 1095.7 1097.2 1101.2 1111.7 1117.0 1295.5 1303.4 1304.9 1328.3 1335.6 6975.2 7056.7 7188.8 7204.7 7208.0 461.1 464.8 467.4 470.1 471.1 5569.4 5626.6 5644.0 5649.1 5650.3 8818.4 8902.6 9133.5 9183.5 9266.9 9004.0 9196.5 9208.3 9227.8 9231.8 7097.8 7131.6 7171.5 7193.4 7218.3 6981.9 7003.2 7027.4 7029.7 7035.1 7913.6 8101.2 8167.9 8234.4 8247.1 8171.9 8397.2 8414.4 8453.5 8479.0 6443.0 6527.9 6584.0 6931.7 6952.8 7140.4 7160.9 7193.7 7209.2 7211.8 6590.2 6749.9 6777.8 6850.6 7026.3 6694.2 6754.9 6784.4 6832.0 6891.1 6772.9 6816.5 6893.7 6897.2 7019.7 6358.5 6444.8 6457.3 6459.1 6482.0 6477.3 6496.1 6498.0 6499.8 6500.3 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | [#4] prototype.html Cycles:180 Average:5541.84 Median:6309.01 stddev:1707.73 (27.1%) stddev-sans-first:1667.16 16:04:07 INFO - PROCESS | 24989 | Values: 332.5 335.0 335.1 343.2 348.0 6182.5 6182.8 6225.2 6276.2 6380.7 6184.4 6215.0 6227.6 6241.4 6277.7 4679.8 4683.8 4686.4 4687.6 4693.6 4708.8 4709.4 4715.1 4738.0 4740.7 4516.6 4517.6 4644.1 4657.6 4661.9 4619.5 4628.1 4642.4 4643.2 4654.4 4012.9 4020.3 4027.7 4035.7 4049.2 5872.0 5924.0 5925.1 5938.0 5959.1 5311.5 5449.6 5462.5 5540.7 5545.0 6585.4 6590.7 6608.9 6609.0 6613.7 4476.4 4485.2 4485.3 4501.1 4517.5 6777.0 6828.0 6858.2 6863.7 6873.6 4605.9 4612.3 4633.1 4634.1 4647.2 4643.3 4657.6 4670.5 4690.2 4695.0 5451.0 5465.9 5467.4 5476.9 5479.6 6487.1 6647.5 6660.3 6692.7 6696.1 1646.5 1647.0 1647.8 1656.2 1658.0 1083.3 1098.1 1100.4 1102.8 1126.1 6300.1 6318.0 6322.8 6331.5 6339.0 6827.8 6851.7 6853.9 6886.7 6902.4 6094.3 6323.3 6325.1 6329.1 6351.1 3717.7 3724.8 3730.1 3743.6 3761.7 7183.1 7187.1 7204.1 7218.9 7227.3 6897.6 6999.6 7018.7 7044.9 7074.9 7120.2 7167.1 7204.3 7221.6 7222.9 6886.1 6939.2 6939.9 6945.4 6959.6 6757.8 6809.4 6865.1 6869.5 6871.8 7189.9 7190.2 7203.0 7235.3 7256.0 4666.6 4688.5 4698.7 4700.3 4711.8 6656.7 6898.4 6929.6 6969.6 6980.1 6721.3 6752.3 6765.3 6782.9 6798.2 6610.1 6729.0 6744.2 6767.4 6784.1 6527.1 6578.9 6588.5 6598.9 6604.3 6745.6 6751.7 6766.7 6768.2 6769.7 6386.7 6531.0 6582.5 6593.9 6594.4 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - PROCESS | 24989 | [#5] yui.html Cycles:180 Average:13838.14 Median:48942.64 stddev:16450.04 (33.6%) stddev-sans-first:16466.71 16:04:07 INFO - PROCESS | 24989 | Values: 724.2 734.6 745.8 824.7 836.1 12604.7 12743.9 12813.2 12842.8 12913.0 12446.8 12515.7 12559.4 12560.0 12587.2 800.3 800.9 817.4 823.6 825.8 792.2 802.7 803.5 804.6 806.3 846.2 846.3 857.2 858.0 858.9 841.7 846.5 847.5 849.3 852.2 624.1 626.9 628.4 628.6 630.8 13115.7 13511.2 13512.3 13537.7 13539.7 11418.8 11602.7 11710.9 12385.4 12442.5 9863.0 10479.9 10597.8 10673.4 10692.1 3580.8 3632.9 3642.8 3660.5 3769.5 49746.3 51594.7 51724.8 51996.7 52131.7 9233.9 9267.3 9282.6 9391.5 9396.5 17565.3 17579.1 17605.5 17613.0 17663.5 7190.9 7210.6 7218.9 7313.6 7331.0 3933.4 4057.8 4058.0 4098.1 4106.1 3132.0 3135.9 3155.9 3156.1 3162.3 563.1 566.5 567.5 578.0 580.7 598.2 627.3 627.7 629.9 638.3 7886.3 8082.0 8093.0 8167.3 8214.1 581.4 629.0 670.4 676.6 684.8 3809.3 3954.7 3986.7 4006.5 4047.7 54441.0 61117.0 61307.0 61332.0 62076.0 46995.0 47590.5 47607.3 47732.8 48047.3 44993.8 49185.0 49226.3 49482.8 49827.8 8488.7 8802.8 9254.5 9273.1 9290.6 35347.8 35559.6 36094.0 36137.0 36769.0 42567.7 47368.3 48022.3 48034.0 48700.3 10741.6 10776.1 10972.3 11045.0 11134.8 11258.9 11281.9 11503.5 11555.4 11722.6 10663.4 10750.8 10756.4 10993.1 11445.5 10790.4 11044.3 11082.8 11113.2 11437.7 9901.6 10085.9 10244.1 10340.1 10532.0 9813.4 9818.3 9842.5 10158.5 10291.8 8785.7 8867.7 9261.2 9542.6 9576.8 16:04:07 INFO - PROCESS | 24989 | -------- Summary: end -------- 16:04:07 INFO - PROCESS | 24989 | 16:04:07 INFO - TEST-INFO | 24989: exit 0 16:04:07 INFO - TEST-OK | dromaeo_css | took 1110605ms 16:04:07 INFO - TEST-START | kraken 16:04:07 INFO - operating with platform_type : linux_ 16:04:07 INFO - Initialising browser for kraken test... 16:04:07 INFO - TEST-INFO | started process 25234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfSDI5V/profile http://localhost:56028/getInfo.html) 16:04:11 INFO - PROCESS | 25234 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 16:04:11 INFO - PROCESS | 25234 | __metrics Screen width/height:1600/1200 16:04:11 INFO - PROCESS | 25234 | colorDepth:24 16:04:11 INFO - PROCESS | 25234 | Browser inner width/height: 1024/697 16:04:11 INFO - PROCESS | 25234 | __metrics 16:04:11 INFO - PROCESS | 25234 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:04:12 INFO - TEST-INFO | 25234: exit 0 16:04:12 INFO - Browser initialized. 16:04:12 INFO - Running cycle 1/1 for kraken test... 16:04:12 INFO - TEST-INFO | started process 25353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfSDI5V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:24 INFO - PROCESS | 25353 | RSS: Main: 150147072 16:04:24 INFO - PROCESS | 25353 | 16:04:26 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:27 INFO - PROCESS | 25353 | RSS: Main: 151011328 16:04:27 INFO - PROCESS | 25353 | 16:04:30 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-dft) 16:04:30 INFO - PROCESS | 25353 | RSS: Main: 151011328 16:04:30 INFO - PROCESS | 25353 | 16:04:33 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-fft) 16:04:34 INFO - PROCESS | 25353 | RSS: Main: 145330176 16:04:34 INFO - PROCESS | 25353 | 16:04:36 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56028/tests/kraken/driver.html?testName=audio-oscillator) 16:04:37 INFO - PROCESS | 25353 | RSS: Main: 146632704 16:04:37 INFO - PROCESS | 25353 | 16:04:39 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:39 INFO - PROCESS | 25353 | RSS: Main: 146587648 16:04:39 INFO - PROCESS | 25353 | 16:04:42 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56028/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:43 INFO - PROCESS | 25353 | RSS: Main: 147832832 16:04:43 INFO - PROCESS | 25353 | 16:04:46 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56028/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:47 INFO - PROCESS | 25353 | RSS: Main: 148860928 16:04:47 INFO - PROCESS | 25353 | 16:04:50 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56028/tests/kraken/driver.html?testName=json-parse-financial) 16:04:50 INFO - PROCESS | 25353 | RSS: Main: 149499904 16:04:50 INFO - PROCESS | 25353 | 16:04:52 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:53 INFO - PROCESS | 25353 | RSS: Main: 147632128 16:04:53 INFO - PROCESS | 25353 | 16:04:54 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:55 INFO - PROCESS | 25353 | RSS: Main: 148615168 16:04:55 INFO - PROCESS | 25353 | 16:04:57 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:58 INFO - PROCESS | 25353 | RSS: Main: 149127168 16:04:58 INFO - PROCESS | 25353 | 16:05:00 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:01 INFO - PROCESS | 25353 | RSS: Main: 148901888 16:05:01 INFO - PROCESS | 25353 | 16:05:03 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:04 INFO - PROCESS | 25353 | RSS: Main: 149508096 16:05:04 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | Cycle 1(1): loaded http://localhost:56028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56028/tests/kraken/driver.html?testName=ai-astar) 16:05:06 INFO - PROCESS | 25353 | RSS: Main: 147894272 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | __start_tp_report 16:05:06 INFO - PROCESS | 25353 | _x_x_mozilla_page_load 16:05:06 INFO - PROCESS | 25353 | _x_x_mozilla_page_load_details 16:05:06 INFO - PROCESS | 25353 | |i|pagename|runs| 16:05:06 INFO - PROCESS | 25353 | |0;ai-astar;114;108;113;115;113;124;112;113;114;112 16:05:06 INFO - PROCESS | 25353 | |1;audio-beat-detection;159;138;158;171;129;154;155;132;160;126 16:05:06 INFO - PROCESS | 25353 | |2;audio-dft;165;164;165;163;162;162;163;173;165;167 16:05:06 INFO - PROCESS | 25353 | |3;audio-fft;77;73;75;83;75;155;72;74;72;75 16:05:06 INFO - PROCESS | 25353 | |4;audio-oscillator;97;97;149;97;97;97;144;97;97;139 16:05:06 INFO - PROCESS | 25353 | |5;imaging-gaussian-blur;111;110;110;111;110;111;110;111;112;110 16:05:06 INFO - PROCESS | 25353 | |6;imaging-darkroom;148;147;147;147;147;147;147;147;148;146 16:05:06 INFO - PROCESS | 25353 | |7;imaging-desaturate;97;97;97;98;97;97;98;97;97;97 16:05:06 INFO - PROCESS | 25353 | |8;json-parse-financial;56;57;57;59;60;57;56;57;55;56 16:05:06 INFO - PROCESS | 25353 | |9;json-stringify-tinderbox;67;68;67;68;68;69;69;68;67;68 16:05:06 INFO - PROCESS | 25353 | |10;stanford-crypto-aes;87;88;92;89;89;89;89;88;91;88 16:05:06 INFO - PROCESS | 25353 | |11;stanford-crypto-ccm;130;129;118;122;120;123;118;126;121;126 16:05:06 INFO - PROCESS | 25353 | |12;stanford-crypto-pbkdf2;144;168;158;156;156;151;158;154;156;145 16:05:06 INFO - PROCESS | 25353 | |13;stanford-crypto-sha256-iterative;70;74;72;71;70;69;69;69;67;69 16:05:06 INFO - PROCESS | 25353 | __end_tp_report 16:05:06 INFO - PROCESS | 25353 | __start_cc_report 16:05:06 INFO - PROCESS | 25353 | _x_x_mozilla_cycle_collect,763 16:05:06 INFO - PROCESS | 25353 | __end_cc_report 16:05:06 INFO - PROCESS | 25353 | __startTimestamp1452125106405__endTimestamp 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | ------- Summary: start ------- 16:05:06 INFO - PROCESS | 25353 | Number of tests: 14 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:4.05 (3.6%) stddev-sans-first:4.29 16:05:06 INFO - PROCESS | 25353 | Values: 114.0 108.0 113.0 115.0 113.0 124.0 112.0 113.0 114.0 112.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:156.50 stddev:15.56 (9.9%) stddev-sans-first:16.01 16:05:06 INFO - PROCESS | 25353 | Values: 159.0 138.0 158.0 171.0 129.0 154.0 155.0 132.0 160.0 126.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:3.25 (2.0%) stddev-sans-first:3.44 16:05:06 INFO - PROCESS | 25353 | Values: 165.0 164.0 165.0 163.0 162.0 162.0 163.0 173.0 165.0 167.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:25.46 (33.9%) stddev-sans-first:26.91 16:05:06 INFO - PROCESS | 25353 | Values: 77.0 73.0 75.0 83.0 75.0 155.0 72.0 74.0 72.0 75.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:97.00 stddev:22.83 (23.5%) stddev-sans-first:23.63 16:05:06 INFO - PROCESS | 25353 | Values: 97.0 97.0 149.0 97.0 97.0 97.0 144.0 97.0 97.0 139.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:05:06 INFO - PROCESS | 25353 | Values: 111.0 110.0 110.0 111.0 110.0 111.0 110.0 111.0 112.0 110.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 16:05:06 INFO - PROCESS | 25353 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:05:06 INFO - PROCESS | 25353 | Values: 97.0 97.0 97.0 98.0 97.0 97.0 98.0 97.0 97.0 97.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.49 (2.6%) stddev-sans-first:1.54 16:05:06 INFO - PROCESS | 25353 | Values: 56.0 57.0 57.0 59.0 60.0 57.0 56.0 57.0 55.0 56.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 16:05:06 INFO - PROCESS | 25353 | Values: 67.0 68.0 67.0 68.0 68.0 69.0 69.0 68.0 67.0 68.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:89.00 stddev:1.49 (1.7%) stddev-sans-first:1.39 16:05:06 INFO - PROCESS | 25353 | Values: 87.0 88.0 92.0 89.0 89.0 89.0 89.0 88.0 91.0 88.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:124.50 stddev:4.30 (3.5%) stddev-sans-first:3.81 16:05:06 INFO - PROCESS | 25353 | Values: 130.0 129.0 118.0 122.0 120.0 123.0 118.0 126.0 121.0 126.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:156.00 stddev:6.88 (4.4%) stddev-sans-first:6.14 16:05:06 INFO - PROCESS | 25353 | Values: 144.0 168.0 158.0 156.0 156.0 151.0 158.0 154.0 156.0 145.0 16:05:06 INFO - PROCESS | 25353 | 16:05:06 INFO - PROCESS | 25353 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.94 (2.8%) stddev-sans-first:2.06 16:05:06 INFO - PROCESS | 25353 | Values: 70.0 74.0 72.0 71.0 70.0 69.0 69.0 69.0 67.0 69.0 16:05:06 INFO - PROCESS | 25353 | -------- Summary: end -------- 16:05:06 INFO - PROCESS | 25353 | 16:05:07 INFO - TEST-INFO | 25353: exit 0 16:05:07 INFO - TEST-OK | kraken | took 59542ms 16:05:07 INFO - TEST-START | v8_7 16:05:07 INFO - operating with platform_type : linux_ 16:05:07 INFO - Initialising browser for v8_7 test... 16:05:07 INFO - TEST-INFO | started process 25642 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXVZZIP/profile http://localhost:56028/getInfo.html) 16:05:10 INFO - PROCESS | 25642 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 16:05:11 INFO - PROCESS | 25642 | __metrics Screen width/height:1600/1200 16:05:11 INFO - PROCESS | 25642 | colorDepth:24 16:05:11 INFO - PROCESS | 25642 | Browser inner width/height: 1024/697 16:05:11 INFO - PROCESS | 25642 | __metrics 16:05:11 INFO - PROCESS | 25642 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:05:12 INFO - TEST-INFO | 25642: exit 0 16:05:12 INFO - Browser initialized. 16:05:12 INFO - Running cycle 1/1 for v8_7 test... 16:05:12 INFO - TEST-INFO | started process 25763 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXVZZIP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:23 INFO - PROCESS | 25763 | RSS: Main: 150585344 16:05:23 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:56028/tests/v8_7/run.html (next: http://localhost:56028/tests/v8_7/run.html) 16:05:45 INFO - PROCESS | 25763 | RSS: Main: 146690048 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | __start_tp_report 16:05:45 INFO - PROCESS | 25763 | _x_x_mozilla_page_load 16:05:45 INFO - PROCESS | 25763 | _x_x_mozilla_page_load_details 16:05:45 INFO - PROCESS | 25763 | |i|pagename|runs| 16:05:45 INFO - PROCESS | 25763 | |0;Richards;168.20857863751053 16:05:45 INFO - PROCESS | 25763 | |1;DeltaBlue;195.88638589618023 16:05:45 INFO - PROCESS | 25763 | |2;Encrypt;286.8617326448652 16:05:45 INFO - PROCESS | 25763 | |3;Decrypt;5208.333333333333 16:05:45 INFO - PROCESS | 25763 | |4;RayTrace;1097.694840834248 16:05:45 INFO - PROCESS | 25763 | |5;Earley;719.9424046076314 16:05:45 INFO - PROCESS | 25763 | |6;Boyer;12345.67901234568 16:05:45 INFO - PROCESS | 25763 | |7;RegExp;25475 16:05:45 INFO - PROCESS | 25763 | |8;Splay;669.7798532354904 16:05:45 INFO - PROCESS | 25763 | |9;NavierStokes;4864.077669902913 16:05:45 INFO - PROCESS | 25763 | __end_tp_report 16:05:45 INFO - PROCESS | 25763 | __startTimestamp1452125145583__endTimestamp 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | ------- Summary: start ------- 16:05:45 INFO - PROCESS | 25763 | Number of tests: 10 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 168.2 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#1] DeltaBlue Cycles:1 Average:195.89 Median:195.89 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 195.9 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#2] Encrypt Cycles:1 Average:286.86 Median:286.86 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 286.9 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 5208.3 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 1097.7 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#5] Earley Cycles:1 Average:719.94 Median:719.94 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 719.9 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 12345.7 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 25475.0 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#8] Splay Cycles:1 Average:669.78 Median:669.78 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 669.8 16:05:45 INFO - PROCESS | 25763 | 16:05:45 INFO - PROCESS | 25763 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 16:05:45 INFO - PROCESS | 25763 | Values: 4864.1 16:05:45 INFO - PROCESS | 25763 | -------- Summary: end -------- 16:05:45 INFO - PROCESS | 25763 | 16:05:46 INFO - TEST-INFO | 25763: exit 0 16:05:46 INFO - TEST-OK | v8_7 | took 39164ms 16:05:46 INFO - SUITE-END | took 1209s 16:05:46 INFO - Completed test suite (00:20:09) 16:05:46 INFO - Working with test: dromaeo_css 16:05:46 INFO - Generating results file: dromaeo_css 16:05:46 INFO - Working with test: kraken 16:05:46 INFO - Generating results file: kraken 16:05:46 INFO - javascript benchmark 16:05:46 INFO - Working with test: v8_7 16:05:46 INFO - Generating results file: v8_7 16:05:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:05:46 INFO - process_Request line: dromaeo_css 7082.80 graph.html#tests=[[72,63,43]] 16:05:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:46 INFO - process_Request line: kraken 1537.80 graph.html#tests=[[232,63,43]] 16:05:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:46 INFO - process_Request line: v8_7 20865.30 graph.html#tests=[[230,63,43]] 16:05:46 INFO - RETURN: dromaeo_css: 7082.80 16:05:46 INFO - RETURN: kraken: 1537.80 16:05:46 INFO - RETURN: v8_7: 20865.30 16:05:46 INFO - javascript benchmark 16:05:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3094.690530946905, 3152.5744024556693, 3175.793573417729, 3198.5332582691053, 3205.903822885314, 5269.077911365515, 5368.141097424413, 5451.482109199625, 5467.535259502947, 5472.288602481677, 5336.866578335544, 5344.171653393721, 5400.351957765064, 5531.225628412026, 5534.667919924807, 4919.508049195088, 4990.176620857555, 5059.418166910816, 5077.441481437039, 5090.618203634724, 5000.599952003831, 5049.141645920203, 5093.032323858455, 5111.361079865017, 5116.718580478072, 4871.732054736988, 4934.851954441372, 5016.272640467148, 5026.969471258401, 5147.639665223436, 4810.446798618169, 4880.194767863299, 4883.267509873512, 4912.680675756064, 4913.778879950411, 4875.561199492063, 4892.07050660377, 4893.119238537062, 4916.041371932474, 4923.729194894279, 5100.821471248489, 5162.5095615916425, 5170.663906846043, 5222.138347172712, 5279.340082489689, 5870.26621672291, 5878.735456904449, 5878.853028674274, 5884.382139875294, 5890.882182356372, 5907.6750778707155, 5942.227510423617, 5951.553633477463, 5956.315023772278, 5959.255093113361, 5271.130263506517, 5407.567394608462, 5413.945860541423, 5480.314960629921, 5502.422245664227, 5866.765329386777, 5876.353601103875, 5892.970535147297, 5893.116032595145, 5921.911171332434, 5611.186377975252, 5664.51851592611, 5669.31968163823, 5675.858103547362, 5694.06048002075, 5755.8561035974435, 5807.88384232313, 5830.650160990269, 5871.794487192928, 5879.941200588025, 5806.79676211339, 5816.5055970243, 5840.065589505659, 5842.240508733922, 5860.384659610765, 5845.976954033027, 5857.88284234313, 5868.295804503487, 5873.970630146822, 5875.676837773964, 4489.932651010237, 4494.325851122358, 4511.842085526991, 4517.051419201939, 4523.117991991596, 3969.702272329587, 3993.1414745829206, 3995.600439955981, 4014.1570270243574, 4027.959720402817, 5435.456454354612, 5504.284443022381, 5519.227308176858, 5521.171824226318, 5532.17017447378, 5735.2257445245195, 5848.298204215436, 5872.588918775645, 5875.851356195491, 5898.793542226002, 5464.153056276284, 5483.616146869761, 5493.972530137324, 5498.890022199534, 5513.2005859151, 4909.214525675875, 4935.87660308488, 4936.3829521309835, 4936.753162341868, 4962.925556116661, 5858.8242352729485, 5910.172575839386, 5972.223610930551, 5992.64044157352, 6084.6349219046115, 5697.0, 5713.885722285448, 5781.988152073286, 5783.132530120515, 5791.449812267828, 5893.793717219876, 5920.733566989582, 5935.228420305332, 5953.672548009901, 5965.6718880461995, 5600.467955544217, 5666.490015898424, 5700.401457846866, 5800.970995144998, 5856.180134781049, 5915.556333275108, 5943.58394912352, 5960.403959604005, 5974.372690867396, 5978.4021597839865, 5609.663420194802, 5779.826605201851, 5820.621659592113, 5821.912671310019, 5845.824625261249, 5664.291963504562, 5723.627964182315, 5833.358330583717, 5850.0932355484965, 5899.734511946886, 5583.916241256466, 5601.29983752031, 5639.887202256014, 5651.124075768263, 5657.745401456862, 5672.914906276326, 5682.346530149086, 5732.59871808986, 5765.827025189251, 5771.134329850556, 5671.631343962629, 5676.375598684059, 5755.625884317506, 5806.5645076618575, 5807.535397168301], "unit": "score", "name": "dojo.html", "value": 5372.898202275464}, {"lowerIsBetter": false, "replicates": [527.2039220776626, 531.4526038180674, 556.7355506134584, 560.5487582496094, 583.932847722512, 33719.494207586875, 34570.0, 34604.13489662756, 34653.61385544579, 34785.65214347856, 37283.25433491328, 38030.23939521208, 38061.80969095157, 38105.42841857374, 38119.0, 8387.538685372318, 8451.661933522682, 8514.191151840565, 8515.276201522878, 8551.914480855174, 8290.502569845798, 8379.748607541784, 8393.916060839374, 8556.572171391406, 8594.398392112555, 8582.656693732244, 8597.226249637532, 8602.526861022641, 8647.264982476498, 8664.0, 8537.701180458685, 8587.742367728979, 8600.397972141953, 8600.913990860105, 8611.655533778641, 8335.83328333436, 8466.83066338676, 8482.53346065966, 8550.74347769568, 8588.269997050258, 38256.23487530234, 38342.80828595867, 38723.0, 38797.224055519015, 38843.8346849595, 3082.8458577071056, 3101.348716769481, 3193.552902593639, 3206.6633003534757, 3568.6966607838103, 29456.41087178266, 29537.852310738308, 30079.849600751855, 30449.23876903073, 30843.537346939815, 3686.7787932724123, 3700.6669399753882, 3729.8881033569037, 3762.7930463824478, 3864.401017842239, 249563.0, 251286.0, 251455.0, 251732.0, 252069.7396513024, 49789.0, 50693.0, 57660.423395766345, 58683.70658146682, 58834.0, 56420.153697694564, 56524.717376413675, 56620.71689641525, 56765.71617141888, 56840.71579642075, 15610.14144222056, 15770.526884193492, 15836.337184595683, 15850.0, 15859.444919427764, 11964.162508624488, 12027.173614200656, 12035.819462708067, 12043.638690839289, 12136.757264854654, 18765.155567999198, 18812.777169484212, 18859.717104243446, 18913.43259702211, 19048.904755476135, 7499.475246634073, 7664.4634875559295, 7684.731034413769, 7809.45333826638, 7896.60516974149, 908.8000639859221, 979.6228452045871, 1030.2427715629008, 1063.9734006649896, 1073.0235485707967, 26472.205833825017, 26874.731252687223, 26975.730242697322, 27252.0, 27261.72738272592, 1029.4235228272191, 1035.3115178406276, 1060.4962642744788, 1080.2978064258139, 1085.3270971997413, 15039.774403383957, 15043.548693539211, 15142.772858407132, 15327.31027103783, 15361.462348817739, 284498.0, 287728.0, 288286.0, 288784.0, 289037.0, 48558.0, 48620.756896215295, 48823.0, 49013.50986490161, 49121.263181052316, 1306.8105124756858, 1336.0714303559128, 1337.806018127366, 1339.1094921877038, 1340.9798853017212, 27825.721742782313, 28926.421471570873, 29012.12963611095, 29174.124776256747, 29439.11682649524, 44810.327845081694, 45617.77191114023, 46002.769986149855, 46123.0, 46130.0, 288399.0, 290074.0, 290976.0, 291816.0, 293260.8706521162, 32834.01497955065, 43199.35200971925, 43308.566914330455, 43385.566144338154, 43534.78232608944, 39021.0, 39220.41169382405, 39225.411618826314, 40393.39409908913, 40937.795311023256, 32857.67142328642, 33493.83253083817, 34014.0, 34022.14944626404, 34220.0, 37603.81198093992, 38536.775431094684, 39381.409278860265, 40512.3923141159, 40530.9867253321, 37605.435918460695, 38318.425223622224, 38396.23207535778, 38615.0, 38816.417753734284, 28859.567106493, 29172.416551669274, 34078.65921340854, 36234.0, 36874.631253688196, 24315.635265471385, 25035.248942531754, 26791.464170716867, 27257.86371068211, 28379.716202837706], "unit": "score", "name": "ext.html", "value": 18193.4880688921}, {"lowerIsBetter": false, "replicates": [340.40429248814576, 344.06071425009725, 344.5658470327387, 345.7441493294961, 346.02076124567463, 11218.887811121886, 11713.472893719781, 14574.052686575378, 15698.607534811621, 16435.178241087942, 17439.91280043598, 17442.12789360533, 17565.560860978483, 17623.383181588648, 17750.201240944156, 5712.257406537145, 5822.475977162055, 5878.2064421303, 5886.676232807194, 5896.35140134587, 5755.568332375088, 5858.518233551336, 5886.999210134266, 5953.642781433106, 5960.463558279754, 5779.162021506879, 5793.4206579341935, 5800.042992906166, 6100.847478813021, 6313.684315784215, 6075.9696201519155, 6196.752129914798, 6202.2247219097835, 6265.655388953605, 6588.209414870246, 6348.523860710465, 6393.776217832354, 6430.871382572369, 6438.645874476902, 6439.517036222255, 22287.0, 22832.77167228323, 23382.18162364326, 23447.882760586257, 23561.88219058911, 2012.9295474658318, 2049.3237231713647, 2232.7767223277706, 2263.569921714869, 2299.3906614747107, 13146.671333216651, 14262.85737142636, 14308.499202527966, 14453.566393008226, 14549.418023279057, 1856.8885866847897, 1875.5686192175876, 1888.792232854385, 1911.6845720456108, 1919.4145785535407, 57564.136537952385, 57867.0, 59009.0, 64152.679236603515, 71387.0, 14818.925905370405, 15211.554902284266, 15222.391104355924, 15249.771253431207, 15298.0, 22997.770022299897, 23464.413389665395, 23707.170249041545, 23754.406139846298, 23902.282931512083, 8804.339674524435, 8881.822363552692, 8963.103689631114, 9029.09709029105, 9044.366894317334, 7644.426667999811, 7665.156832748393, 7690.307872291409, 7729.149793522708, 7752.0, 7846.921530784619, 7866.505363980826, 7889.566073865878, 7937.047554293522, 7958.801029974297, 1837.4303965770655, 3162.905112846618, 3216.388886111631, 3217.951730724041, 3264.657210992859, 825.6367198432671, 918.6233644205844, 922.2852289475576, 927.9536023198813, 980.7204946590188, 16103.0, 16109.355625774837, 16277.430289940032, 16442.0, 16590.585235369213, 857.0101532729707, 878.0604752914448, 889.4352086425038, 928.1275600935099, 996.1881066930429, 8968.757810547364, 9362.719118426457, 9366.95316523413, 9422.340436169403, 9587.280953928483, 503870.0, 507247.0, 537639.0, 566450.0, 580436.0, 72578.0, 80155.0, 80731.0, 81138.18861811307, 83260.0, 1153.2158132469833, 1155.2837240910521, 1184.490669012333, 1204.3436327201696, 1228.969275768113, 15718.528444146694, 16013.359465621244, 16070.758938615696, 16100.0, 16390.508284751475, 34918.0, 34949.47575786315, 35594.46608300826, 36125.81937090298, 36536.26927461489, 46116.07767844691, 47556.28665570088, 49024.26463602977, 49383.0, 49413.50586494233, 9165.587548560197, 9566.426014439156, 9602.66390676351, 9766.951165244129, 9783.266255031043, 11467.770644586895, 11543.249688770204, 11548.307101573933, 12431.689207769878, 17396.217170227115, 13170.868291317347, 14065.296735162996, 14494.188226471691, 15158.621034474227, 15470.303836327617, 14632.0, 14815.111093334435, 14996.100233985995, 15323.46367877119, 15394.15332156742, 15039.398424062914, 15364.923175384052, 15365.923170384523, 15495.690086198438, 15551.14468704187, 9044.457332560067, 9092.727218183465, 9554.61781528731, 9641.325107242426, 9679.467629280176, 10112.898871011195, 13260.801087983495, 13761.931190343985, 13962.301884905512, 14007.229602371968], "unit": "score", "name": "jquery.html", "value": 9668.653034972587}, {"lowerIsBetter": false, "replicates": [1464.5899148238493, 1467.2223721427645, 1617.5066604685567, 1752.0101142854294, 1787.2314904591021, 6798.388145066943, 6876.724931002766, 7512.323890849822, 7573.129090154634, 7639.083310002808, 7169.42644588433, 7317.4511911606705, 7385.150707668619, 7388.224236455162, 7418.443616728753, 2232.720909886264, 2275.408393817611, 2276.4764104256033, 2281.851679640826, 2288.9084436622516, 2233.419310979141, 2267.716535433071, 2273.499830037389, 2283.4291427143216, 2287.142321629389, 2251.324602619216, 2253.5830871288863, 2255.424866659008, 2274.101729816721, 2276.9886150569305, 2226.443389152712, 2235.3964429604, 2250.606143924823, 2271.3867255840996, 2282.6005449046434, 2248.651459023854, 2253.853499522526, 2263.343630347197, 2271.7841805028497, 2279.954400911989, 7598.582077985764, 7624.961875190644, 7626.237376262385, 7638.5798781067015, 7656.808579785495, 4485.461744590637, 4549.181147393468, 4622.2835460503675, 4632.791524381411, 4638.8608341749805, 2996.16107489901, 3047.0401823425773, 3098.581691471645, 3127.2807254331633, 3159.526071089332, 917.6146018672107, 920.6823645842173, 927.2535608834885, 980.3578655980344, 990.173205373514, 10299.382037077725, 10326.9483652582, 10455.68632941013, 10484.423356715377, 10486.842697359545, 4099.446574712376, 4135.524414692289, 4136.9793151034655, 4173.040200753783, 4194.706370554093, 8878.245349145394, 8941.061188575106, 8950.239229665422, 8998.235150012191, 8999.05509921462, 4647.674662773574, 4654.394928659252, 4657.301404789308, 4658.534146585314, 4659.4175728034, 3758.473813666089, 3853.479780229633, 4093.0, 4205.558416366299, 4246.447961765012, 3503.3168532136497, 3508.7193024557973, 3511.894643160709, 3519.7008254298157, 3546.5034895114704, 1095.6822521468684, 1097.1771171621283, 1101.1686176936362, 1111.6887271563976, 1117.0337657925998, 1295.5400832704443, 1303.426492343366, 1304.8695130487065, 1328.2960031183488, 1335.6460537957448, 6975.162980442379, 7056.682449289794, 7188.82027949295, 7204.747833825896, 7207.990881276625, 461.05943874496324, 464.7885212228428, 467.4460763994677, 470.1396444506545, 471.1166562694947, 5569.359523654832, 5626.634268772516, 5644.040513112781, 5649.096144616841, 5650.3219613646625, 8818.382713210141, 8902.59938302765, 9133.49765762876, 9183.540822958825, 9266.860997085048, 9004.0, 9196.494192819326, 9208.309376796768, 9227.815443691088, 9231.76920576991, 7097.787066388017, 7131.607761573059, 7171.462140339496, 7193.424526038009, 7218.27817218274, 6981.860362792817, 7003.229644739176, 7027.402670773042, 7029.683664235019, 7035.085438892911, 7913.604319783873, 8101.230383113595, 8167.877481837896, 8234.423590348619, 8247.134050924567, 8171.877421838558, 8397.244248017707, 8414.368922330972, 8453.535055571756, 8478.957605211934, 6443.0335449682925, 6527.869442611216, 6584.0, 6931.6880740367815, 6952.791416257521, 7140.39306658919, 7160.856782864418, 7193.676284567312, 7209.170945341353, 7211.783646490614, 6590.209174898851, 6749.898751518829, 6777.796666100025, 6850.588964662136, 7026.262242464672, 6694.163229596301, 6754.86490270182, 6784.423324017316, 6831.965840170966, 6891.104156459829, 6772.898406523807, 6816.522843400914, 6893.724251030103, 6897.206821215424, 7019.719211231493, 6358.523110766619, 6444.8388790280615, 6457.257415397289, 6459.095726598186, 6481.967590162019, 6477.255115661759, 6496.123023391781, 6498.0, 6499.772507962199, 6500.3174666659315], "unit": "score", "name": "mootools.html", "value": 4304.869763714744}, {"lowerIsBetter": false, "replicates": [332.49128832885685, 334.954781104551, 335.11028220075707, 343.22773759042155, 348.030734404683, 6182.536309776773, 6182.845428864275, 6225.159603453532, 6276.1527193828815, 6380.680965951707, 6184.350643182469, 6215.036669316252, 6227.629921417292, 6241.407066328703, 6277.717502712378, 4679.759863636139, 4683.8360657377, 4686.367340409035, 4687.578117969382, 4693.624510039189, 4708.7645617719145, 4709.387779588666, 4715.08055929094, 4738.028704115665, 4740.71555706657, 4516.593506584407, 4517.593416592506, 4644.140833945714, 4657.627389808824, 4661.86014419568, 4619.491855895849, 4628.097520983392, 4642.3500709900645, 4643.16423043852, 4654.418197725285, 4012.8996775080564, 4020.2562525932794, 4027.7180597358197, 4035.677145828356, 4049.1699201663587, 5872.0, 5923.970380148115, 5925.140854576105, 5938.0, 5959.0763431668165, 5311.548518375943, 5449.64577302474, 5462.453754624546, 5540.695261760601, 5544.972275138599, 6585.440237579812, 6590.736370545173, 6608.9339106608795, 6609.0, 6613.669316534154, 4476.37330773692, 4485.237509623372, 4485.304777759453, 4501.099780044005, 4517.525659805706, 6776.966115169442, 6827.965860170667, 6858.211305699809, 6863.691133898987, 6873.621950792704, 4605.930911036337, 4612.285095810088, 4633.050224703928, 4634.119517291704, 4647.209974304376, 4643.303504474288, 4657.580817726353, 4670.462896766848, 4690.249560070372, 4694.953050469451, 5451.0, 5465.9180112298345, 5467.398586155519, 5476.890462190734, 5479.616426850162, 6487.091807147003, 6647.534672572873, 6660.333966603301, 6692.732290708317, 6696.129503164558, 1646.514278287908, 1646.9588260293588, 1647.7940257467817, 1656.2215758593443, 1658.0300524193242, 1083.344576531203, 1098.0831006109988, 1100.4112799652148, 1102.8089663163923, 1126.14975693351, 6300.054991751274, 6317.9684101580115, 6322.810315690536, 6331.525135614847, 6339.0, 6827.761028364082, 6851.725930962705, 6853.862922741518, 6886.655667216719, 6902.413294869892, 6094.268687757498, 6323.27282362525, 6325.114483972247, 6329.050642403677, 6351.110844481776, 3717.7211709121925, 3724.7578907370935, 3730.1047748540695, 3743.5882052974152, 3761.661450469416, 7183.102112235971, 7187.137543494814, 7204.135503739585, 7218.927810721931, 7227.349538541556, 6897.55165914214, 6999.580025198505, 7018.719251229996, 7044.894326585106, 7074.893876591856, 7120.181179164462, 7167.104111986002, 7204.279572042754, 7221.602811845399, 7222.927770722331, 6886.10480637534, 6939.201991770809, 6939.895901561582, 6945.444364450933, 6959.61722105289, 6757.763478278237, 6809.4211991979255, 6865.141857267841, 6869.519133660596, 6871.828204294932, 7189.892151617834, 7190.245024272376, 7203.0, 7235.3488186063505, 7255.963720181366, 4666.580007799314, 4688.460827004938, 4698.671093023456, 4700.2949557566635, 4711.78796954131, 6656.7004484797335, 6898.379145876896, 6929.618870962146, 6969.616671083139, 6980.127484064492, 6721.294264102199, 6752.291009444134, 6765.2896445872475, 6782.932170678428, 6798.218204906301, 6610.10763546915, 6729.0, 6744.190697116182, 6767.39093481589, 6784.118064651564, 6527.086207930988, 6578.868422631616, 6588.538802283794, 6598.868022639616, 6604.273529911802, 6745.561538499982, 6751.72993080291, 6766.661666916536, 6768.221654509597, 6769.729210831709, 6386.680665966776, 6530.967345163243, 6582.506312026521, 6593.868122637425, 6594.406503414716], "unit": "score", "name": "prototype.html", "value": 4981.574537193964}, {"lowerIsBetter": false, "replicates": [724.2250791652932, 734.5959722152814, 745.79490640074, 824.7443292579301, 836.1387770596284, 12604.684882877933, 12743.936280318609, 12813.167144135625, 12842.807357889638, 12913.0, 12446.751064978695, 12515.749685006294, 12559.372031398416, 12559.99520038397, 12587.181833180837, 800.3197282310034, 800.8598495263305, 817.3951276055735, 823.5840900345318, 825.7564018614523, 792.2473650032464, 802.7391097893208, 803.5459965119688, 804.5936801915054, 806.2501873257868, 846.2341580869293, 846.3398549131687, 857.2070834478114, 858.0175698824874, 858.8539948208788, 841.6843683618642, 846.5174850335311, 847.5211505499373, 849.2781136034383, 852.2074470742269, 624.082598580091, 626.9122322874802, 628.3779058731868, 628.6353914729445, 630.782380078872, 13115.737685246337, 13511.189328640216, 13512.324383780771, 13537.729245415136, 13539.729205415935, 11418.771624567462, 11602.6519204424, 11710.941445292805, 12385.442655080453, 12442.502299907992, 9863.0, 10479.895201047968, 10597.84103238452, 10673.359598424042, 10692.144628429707, 3580.7825339384735, 3632.909177270589, 3642.8360723767228, 3660.4509323601405, 3769.5288088988877, 49746.2538061933, 51594.74202628963, 51724.824927530324, 51996.74001630006, 52131.73934130305, 9233.907660923305, 9267.304952128618, 9282.574537064587, 9391.483468409304, 9396.48319342429, 17565.297388104587, 17579.12104394775, 17605.471835844946, 17613.0, 17663.470095897144, 7190.9280907191305, 7210.567365958059, 7218.917162425678, 7313.561186328731, 7331.032112490937, 3933.3903244997073, 4057.797110144481, 4057.9797101014306, 4098.098418347959, 4106.137711080706, 3131.9843400783307, 3135.8745650173737, 3155.857986390618, 3156.100511354253, 3162.2726772841916, 563.0737436916249, 566.5127989928658, 567.5487987050304, 578.0375674501992, 580.6516090345843, 598.2491972574478, 627.3412916437723, 627.733213384319, 629.9401556852092, 638.296817931781, 7886.290233878978, 8082.0301563811545, 8092.959535202404, 8167.346612271004, 8214.096449390563, 581.4040608376448, 628.9528285378615, 670.3844328429042, 676.6346173066489, 684.815099923018, 3809.276237514863, 3954.703397245218, 3986.7209295349626, 4006.4591280177387, 4047.6964227683043, 54441.0, 61117.0, 61307.0, 61332.0, 62076.0, 46995.0, 47590.524094759305, 47607.28589071167, 47732.7613361931, 48047.279290810664, 44993.775031124635, 49185.01629967381, 49226.26160607594, 49482.752586236835, 49827.75086124546, 8488.702895398632, 8802.779930501789, 9254.4910029949, 9273.119053689888, 9290.58192381331, 35347.82326088456, 35559.64440355667, 36094.0, 36137.0, 36769.0, 42567.712516774256, 47368.28947565858, 48022.27966580574, 48034.0, 48700.269495958295, 10741.570337186426, 10776.137908967106, 10972.286801357886, 11045.0, 11134.832977505506, 11258.887411125785, 11281.887181128412, 11503.53985840557, 11555.422228888354, 11722.58970936013, 10663.4135122569, 10750.8387374191, 10756.354618722902, 10993.120550355792, 11445.484953177294, 10790.406527640742, 11044.33733975964, 11082.833757493805, 11113.166512511432, 11437.734364495469, 9901.603935842486, 10085.949570252102, 10244.129249013618, 10340.069393754598, 10532.0, 9813.362131461432, 9818.30504420293, 9842.45866477322, 10158.542865570918, 10291.845622315821, 8785.692500762443, 8867.73396798097, 9261.212796912338, 9542.570584323861, 9576.808463830825], "unit": "score", "name": "yui.html", "value": 6228.352820011433}], "name": "dromaeo_css", "value": 7082.800119644339}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 113.0, 115.0, 113.0, 124.0, 112.0, 113.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [159.0, 138.0, 158.0, 171.0, 129.0, 154.0, 155.0, 132.0, 160.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 165.0, 163.0, 162.0, 162.0, 163.0, 173.0, 165.0, 167.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 75.0, 83.0, 75.0, 155.0, 72.0, 74.0, 72.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 149.0, 97.0, 97.0, 97.0, 144.0, 97.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 112.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 98.0, 97.0, 97.0, 98.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 59.0, 60.0, 57.0, 56.0, 57.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 92.0, 89.0, 89.0, 89.0, 89.0, 88.0, 91.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.0}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 118.0, 122.0, 120.0, 123.0, 118.0, 126.0, 121.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [144.0, 168.0, 158.0, 156.0, 156.0, 151.0, 158.0, 154.0, 156.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.6}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 72.0, 71.0, 70.0, 69.0, 69.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1537.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.20857863751053], "unit": "score", "name": "Richards", "value": 209.87038999999996}, {"lowerIsBetter": false, "replicates": [195.88638589618023], "unit": "score", "name": "DeltaBlue", "value": 337.5323900000001}, {"lowerIsBetter": false, "replicates": [286.8617326448652], "unit": "score", "name": "Encrypt", "value": 927.906966}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1097.694840834248], "unit": "score", "name": "RayTrace", "value": 674.1299790000003}, {"lowerIsBetter": false, "replicates": [719.9424046076314], "unit": "score", "name": "Earley", "value": 925.7171069999997}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [669.7798532354904], "unit": "score", "name": "Splay", "value": 121.66833565737052}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20865.301349094305}]} 16:05:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20865.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1537.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7082.80"}}} 16:05:46 INFO - Return code: 0 16:05:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:05:46 INFO - # TBPL SUCCESS # 16:05:46 INFO - Running post-action listener: _resource_record_post_action 16:05:46 INFO - Running post-run listener: _resource_record_post_run 16:05:47 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 563793920; Read time: 4; Write time: 484128 16:05:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238903296; Read time: 0; Write time: 281640 16:05:47 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318029824; Read time: 4; Write time: 201444 16:05:47 INFO - Running post-run listener: _upload_blobber_files 16:05:47 INFO - Blob upload gear active. 16:05:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:05:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:05:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:05:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:05:48 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:05:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:05:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:49 INFO - (blobuploader) - INFO - Done attempting. 16:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:50 INFO - (blobuploader) - INFO - Done attempting. 16:05:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:50 INFO - Return code: 0 16:05:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:05:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f7ad0058d6935e19856cd660c03987b3aa0aa474d6aaf7fbf1fc11398718530f418fc9da833b3ca0d43cc728e6d1c03d897c39297faa0295f396e9632c51ae9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8e49d2671f29c9b7f842498e96f53d02007b37b171ebcf04cda7152795c3984b2ca01c7ff598aae05c59395e345b13e3cc9a829ca6fbabe0758666f51a604ea"} 16:05:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:05:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:05:50 INFO - Contents: 16:05:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f7ad0058d6935e19856cd660c03987b3aa0aa474d6aaf7fbf1fc11398718530f418fc9da833b3ca0d43cc728e6d1c03d897c39297faa0295f396e9632c51ae9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8e49d2671f29c9b7f842498e96f53d02007b37b171ebcf04cda7152795c3984b2ca01c7ff598aae05c59395e345b13e3cc9a829ca6fbabe0758666f51a604ea"} 16:05:50 INFO - Copying logs to upload dir... 16:05:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.944077 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-06 16:05:50.128815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 16:05:50.132194) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f7ad0058d6935e19856cd660c03987b3aa0aa474d6aaf7fbf1fc11398718530f418fc9da833b3ca0d43cc728e6d1c03d897c39297faa0295f396e9632c51ae9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8e49d2671f29c9b7f842498e96f53d02007b37b171ebcf04cda7152795c3984b2ca01c7ff598aae05c59395e345b13e3cc9a829ca6fbabe0758666f51a604ea"} build_url:https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/GBJSgr0JQ1W-rdSZzOI4CA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f7ad0058d6935e19856cd660c03987b3aa0aa474d6aaf7fbf1fc11398718530f418fc9da833b3ca0d43cc728e6d1c03d897c39297faa0295f396e9632c51ae9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8e49d2671f29c9b7f842498e96f53d02007b37b171ebcf04cda7152795c3984b2ca01c7ff598aae05c59395e345b13e3cc9a829ca6fbabe0758666f51a604ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 16:05:50.156794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:05:50.157115) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452122435.141900-1966243265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004786 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:05:50.241968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 16:05:50.242276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 16:05:50.242554) ========= ========= Total master_lag: 0.25 =========