builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1450817069.02 results: success (0) buildid: 20151222103016 builduid: 9b35ce25d0b047838c77ace0556029b6 revision: 74d2f955790a65ffd4a11075b08937536cfc5272 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.022932) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.023698) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.024190) ========= 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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.056485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.056795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.107056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.107410) ========= 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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.158167) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.158627) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.159159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.159619) ========= 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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 12:44:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-22 12:44:29 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.351154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.351451) ========= 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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015826 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.402890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.403215) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 74d2f955790a65ffd4a11075b08937536cfc5272 --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 74d2f955790a65ffd4a11075b08937536cfc5272 --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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 12:44:29,738 truncating revision to first 12 chars 2015-12-22 12:44:29,738 Setting DEBUG logging. 2015-12-22 12:44:29,738 attempt 1/10 2015-12-22 12:44:29,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/74d2f955790a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 12:44:29,981 unpacking tar archive at: mozilla-inbound-74d2f955790a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.951584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.951878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.961116) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.961429) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 12:44:29.961857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-22 12:44:29.962164) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:44:30 INFO - MultiFileLogger online at 20151222 12:44:30 in /builds/slave/test-pgo 12:44:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:44:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:44:30 INFO - {'append_to_log': False, 12:44:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:44:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:44:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:44:30 INFO - 'branch': 'Mozilla-Inbound', 12:44:30 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:30 INFO - 'config_files': ('talos/linux_config.py',), 12:44:30 INFO - 'default_actions': ('clobber', 12:44:30 INFO - 'read-buildbot-config', 12:44:30 INFO - 'download-and-extract', 12:44:30 INFO - 'populate-webroot', 12:44:30 INFO - 'create-virtualenv', 12:44:30 INFO - 'install', 12:44:30 INFO - 'run-tests'), 12:44:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:30 INFO - 'download_minidump_stackwalk': True, 12:44:30 INFO - 'download_symbols': 'ondemand', 12:44:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:30 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:30 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:30 INFO - 'installer_path': 'installer.exe', 12:44:30 INFO - 'log_level': 'info', 12:44:30 INFO - 'log_name': 'talos', 12:44:30 INFO - 'log_to_console': True, 12:44:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:44:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:44:30 INFO - 'opt_config_files': (), 12:44:30 INFO - 'pip_index': False, 12:44:30 INFO - 'sps_profile': False, 12:44:30 INFO - 'sps_profile_interval': 0, 12:44:30 INFO - 'suite': 'dromaeojs', 12:44:30 INFO - 'system_bits': '64', 12:44:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:30 INFO - 'title': 'talos-linux64-ix-008', 12:44:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:30 INFO - 'use_talos_json': True, 12:44:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:44:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:30 INFO - 'work_dir': 'build'} 12:44:30 INFO - ##### 12:44:30 INFO - ##### Running clobber step. 12:44:30 INFO - ##### 12:44:30 INFO - Running pre-action listener: _resource_record_pre_action 12:44:30 INFO - Running main action method: clobber 12:44:30 INFO - rmtree: /builds/slave/test-pgo/build 12:44:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:44:30 INFO - Running post-action listener: _resource_record_post_action 12:44:30 INFO - ##### 12:44:30 INFO - ##### Running read-buildbot-config step. 12:44:30 INFO - ##### 12:44:30 INFO - Running pre-action listener: _resource_record_pre_action 12:44:30 INFO - Running main action method: read_buildbot_config 12:44:30 INFO - Using buildbot properties: 12:44:30 INFO - { 12:44:30 INFO - "project": "", 12:44:30 INFO - "product": "firefox", 12:44:30 INFO - "script_repo_revision": "production", 12:44:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:44:30 INFO - "repository": "", 12:44:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:44:30 INFO - "buildid": "20151222103016", 12:44:30 INFO - "pgo_build": "True", 12:44:30 INFO - "basedir": "/builds/slave/test-pgo", 12:44:30 INFO - "buildnumber": 573, 12:44:30 INFO - "slavename": "talos-linux64-ix-008", 12:44:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:44:30 INFO - "platform": "ubuntu64_hw", 12:44:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:44:30 INFO - "branch": "mozilla-inbound", 12:44:30 INFO - "repo_path": "integration/mozilla-inbound", 12:44:30 INFO - "revision": "74d2f955790a65ffd4a11075b08937536cfc5272", 12:44:30 INFO - "stage_platform": "linux64-pgo", 12:44:30 INFO - "builduid": "9b35ce25d0b047838c77ace0556029b6", 12:44:30 INFO - "slavebuilddir": "test" 12:44:30 INFO - } 12:44:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:44:30 INFO - Running post-action listener: _resource_record_post_action 12:44:30 INFO - ##### 12:44:30 INFO - ##### Running download-and-extract step. 12:44:30 INFO - ##### 12:44:30 INFO - Running pre-action listener: _resource_record_pre_action 12:44:30 INFO - Running main action method: download_and_extract 12:44:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 12: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')]} 12:44:30 INFO - https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/test_packages.json 12:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/test_packages.json 12:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:44:35 INFO - Downloaded 1302 bytes. 12:44:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:44:35 INFO - Using the following test package requirements: 12:44:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:44:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'jsshell-linux-x86_64.zip'], 12:44:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:44:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:44:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:44:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:44:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:44:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:44: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')]} 12:44:35 INFO - https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:36 INFO - Downloaded 23176376 bytes. 12:44:36 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 12:44:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:44:36 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 12:44:37 INFO - Return code: 0 12:44:37 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 12:44:37 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')]} 12:44:37 INFO - https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:44:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:44:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:44:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:45 INFO - Downloaded 23176376 bytes. 12:44:45 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 12:44:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:44:45 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 12:44:47 INFO - Return code: 0 12:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:47 INFO - https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:49 INFO - Downloaded 11132277 bytes. 12:44:49 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 12:44:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:49 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 12:44:49 INFO - Return code: 0 12:44:49 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')]} 12:44:49 INFO - https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qSNSP7dwQe-_NgOCDWz2AA/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 12:44:50 INFO - Downloaded 54831559 bytes. 12:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:44:50 INFO - mkdir: /builds/slave/test-pgo/properties 12:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:44:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:44:50 INFO - Contents: 12:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:44:50 INFO - Running post-action listener: _resource_record_post_action 12:44:50 INFO - Running post-action listener: set_extra_try_arguments 12:44:50 INFO - ##### 12:44:50 INFO - ##### Running populate-webroot step. 12:44:50 INFO - ##### 12:44:50 INFO - Running pre-action listener: _resource_record_pre_action 12:44:50 INFO - Running main action method: populate_webroot 12:44:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:44:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:44:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:44:50 INFO - '--tppagecycles', 12:44:50 INFO - '7'], 12:44:50 INFO - 'tests': ['tsvgm']}}, 12:44:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:44:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:44:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:44:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:44:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'tests': ['damp', 'tps']}, 12:44:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['damp', 'tps']}, 12:44:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:44:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:44:50 INFO - 'other': {'tests': ['a11yr', 12:44:50 INFO - 'ts_paint', 12:44:50 INFO - 'tpaint', 12:44:50 INFO - 'sessionrestore', 12:44:50 INFO - 'sessionrestore_no_auto_restore']}, 12:44:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['a11yr', 12:44:50 INFO - 'ts_paint', 12:44:50 INFO - 'tpaint', 12:44:50 INFO - 'sessionrestore', 12:44:50 INFO - 'sessionrestore_no_auto_restore']}, 12:44:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['a11yr', 12:44:50 INFO - 'ts_paint', 12:44:50 INFO - 'tpaint', 12:44:50 INFO - 'sessionrestore', 12:44:50 INFO - 'sessionrestore_no_auto_restore']}, 12:44:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['a11yr', 12:44:50 INFO - 'ts_paint', 12:44:50 INFO - 'tpaint', 12:44:50 INFO - 'sessionrestore', 12:44:50 INFO - 'sessionrestore_no_auto_restore']}, 12:44:50 INFO - 'other_l64': {'tests': ['a11yr', 12:44:50 INFO - 'ts_paint', 12:44:50 INFO - 'tpaint', 12:44:50 INFO - 'sessionrestore', 12:44:50 INFO - 'sessionrestore_no_auto_restore']}, 12:44:50 INFO - 'other_nol64': {'tests': ['a11yr', 12:44:50 INFO - 'ts_paint', 12:44:50 INFO - 'tpaint', 12:44:50 INFO - 'sessionrestore', 12:44:50 INFO - 'sessionrestore_no_auto_restore']}, 12:44:50 INFO - 'svgr': {'tests': ['tsvgx', 12:44:50 INFO - 'tsvgr_opacity', 12:44:50 INFO - 'tart', 12:44:50 INFO - 'tscrollx', 12:44:50 INFO - 'cart']}, 12:44:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['tsvgx', 12:44:50 INFO - 'tsvgr_opacity', 12:44:50 INFO - 'tart', 12:44:50 INFO - 'tscrollx', 12:44:50 INFO - 'cart']}, 12:44:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'tests': ['tp5o']}, 12:44:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'talos_options': ['--e10s'], 12:44:50 INFO - 'tests': ['tp5o']}, 12:44:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'talos_options': ['--xperf_path', 12:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:50 INFO - 'tests': ['tp5n']}, 12:44:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:50 INFO - 'talos_options': ['--e10s', 12:44:50 INFO - '--xperf_path', 12:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:50 INFO - 'tests': ['tp5n']}}, 12:44:50 INFO - 'talos.zip': {'path': '', 12:44:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:44:50 INFO - Running post-action listener: _resource_record_post_action 12:44:50 INFO - ##### 12:44:50 INFO - ##### Running create-virtualenv step. 12:44:50 INFO - ##### 12:44:50 INFO - Running pre-action listener: _resource_record_pre_action 12:44:50 INFO - Running main action method: create_virtualenv 12:44:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:44:50 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 12:44:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:44:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:44:51 INFO - Using real prefix '/usr' 12:44:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:44:51 INFO - Installing distribute.............................................................................................................................................................................................done. 12:44:53 INFO - Installing pip.................done. 12:44:53 INFO - Return code: 0 12:44:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12: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')]} 12:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:53 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:44:53 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 12:44:53 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 12:44:53 INFO - Using env: {'DISPLAY': ':0', 12:44:53 INFO - 'HOME': '/home/cltbld', 12:44:53 INFO - 'LANG': 'en_US.UTF-8', 12:44:53 INFO - 'LANGUAGE': 'en_US:en', 12:44:53 INFO - 'LOGNAME': 'cltbld', 12:44:53 INFO - 'MAIL': '/var/mail/cltbld', 12:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:53 INFO - 'MOZ_NO_REMOTE': '1', 12:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:53 INFO - 'NO_EM_RESTART': '1', 12:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:53 INFO - 'SHELL': '/bin/bash', 12:44:53 INFO - 'SHLVL': '1', 12:44:53 INFO - 'TERM': 'linux', 12:44:53 INFO - 'TMOUT': '86400', 12:44:53 INFO - 'USER': 'cltbld', 12:44:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:53 INFO - '_': '/tools/buildbot/bin/python'} 12:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:53 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 12:44:53 INFO - Cleaning up... 12:44:53 INFO - Return code: 0 12:44:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12: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')]} 12:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:53 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:44:53 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 12:44:53 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 12:44:53 INFO - Using env: {'DISPLAY': ':0', 12:44:53 INFO - 'HOME': '/home/cltbld', 12:44:53 INFO - 'LANG': 'en_US.UTF-8', 12:44:53 INFO - 'LANGUAGE': 'en_US:en', 12:44:53 INFO - 'LOGNAME': 'cltbld', 12:44:53 INFO - 'MAIL': '/var/mail/cltbld', 12:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:53 INFO - 'MOZ_NO_REMOTE': '1', 12:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:53 INFO - 'NO_EM_RESTART': '1', 12:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:53 INFO - 'SHELL': '/bin/bash', 12:44:53 INFO - 'SHLVL': '1', 12:44:53 INFO - 'TERM': 'linux', 12:44:53 INFO - 'TMOUT': '86400', 12:44:53 INFO - 'USER': 'cltbld', 12:44:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:53 INFO - '_': '/tools/buildbot/bin/python'} 12:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:53 INFO - Downloading/unpacking psutil>=0.7.1 12:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:44:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:44:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:44:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:55 INFO - Installing collected packages: psutil 12:44:55 INFO - Running setup.py install for psutil 12:44:55 INFO - building 'psutil._psutil_linux' extension 12:44:55 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 12:44:55 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 12:44:55 INFO - building 'psutil._psutil_posix' extension 12:44:55 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 12:44:56 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 12:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:56 INFO - Successfully installed psutil 12:44:56 INFO - Cleaning up... 12:44:56 INFO - Return code: 0 12:44:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:44:56 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')]} 12:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:56 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')]} 12:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:56 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:44:56 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 12:44:56 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 12:44:56 INFO - Using env: {'DISPLAY': ':0', 12:44:56 INFO - 'HOME': '/home/cltbld', 12:44:56 INFO - 'LANG': 'en_US.UTF-8', 12:44:56 INFO - 'LANGUAGE': 'en_US:en', 12:44:56 INFO - 'LOGNAME': 'cltbld', 12:44:56 INFO - 'MAIL': '/var/mail/cltbld', 12:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:56 INFO - 'MOZ_NO_REMOTE': '1', 12:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:56 INFO - 'NO_EM_RESTART': '1', 12:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:56 INFO - 'SHELL': '/bin/bash', 12:44:56 INFO - 'SHLVL': '1', 12:44:56 INFO - 'TERM': 'linux', 12:44:56 INFO - 'TMOUT': '86400', 12:44:56 INFO - 'USER': 'cltbld', 12:44:56 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:56 INFO - '_': '/tools/buildbot/bin/python'} 12:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:44:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:44:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:44:58 INFO - Installing collected packages: mozsystemmonitor 12:44:58 INFO - Running setup.py install for mozsystemmonitor 12:44:58 INFO - Successfully installed mozsystemmonitor 12:44:58 INFO - Cleaning up... 12:44:58 INFO - Return code: 0 12:44:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:44:58 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')]} 12:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:58 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')]} 12:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:58 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:44:58 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 12:44:58 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 12:44:58 INFO - Using env: {'DISPLAY': ':0', 12:44:58 INFO - 'HOME': '/home/cltbld', 12:44:58 INFO - 'LANG': 'en_US.UTF-8', 12:44:58 INFO - 'LANGUAGE': 'en_US:en', 12:44:58 INFO - 'LOGNAME': 'cltbld', 12:44:58 INFO - 'MAIL': '/var/mail/cltbld', 12:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:58 INFO - 'MOZ_NO_REMOTE': '1', 12:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:58 INFO - 'NO_EM_RESTART': '1', 12:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:58 INFO - 'SHELL': '/bin/bash', 12:44:58 INFO - 'SHLVL': '1', 12:44:58 INFO - 'TERM': 'linux', 12:44:58 INFO - 'TMOUT': '86400', 12:44:58 INFO - 'USER': 'cltbld', 12:44:58 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:58 INFO - '_': '/tools/buildbot/bin/python'} 12:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:58 INFO - Downloading/unpacking blobuploader==1.2.4 12:44:58 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 12:44:58 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 12:44:58 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 12:44:58 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 12:44:58 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 12:44:58 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 12:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 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 12:45:00 INFO - Downloading docopt-0.6.1.tar.gz 12:45:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:45:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:01 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:01 INFO - Running setup.py install for blobuploader 12:45:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:45:01 INFO - Running setup.py install for requests 12:45:01 INFO - Running setup.py install for docopt 12:45:01 INFO - Successfully installed blobuploader requests docopt 12:45:01 INFO - Cleaning up... 12:45:01 INFO - Return code: 0 12:45:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12: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')]} 12:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:01 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:45:01 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 12:45:01 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 12:45:01 INFO - Using env: {'DISPLAY': ':0', 12:45:01 INFO - 'HOME': '/home/cltbld', 12:45:01 INFO - 'LANG': 'en_US.UTF-8', 12:45:01 INFO - 'LANGUAGE': 'en_US:en', 12:45:01 INFO - 'LOGNAME': 'cltbld', 12:45:01 INFO - 'MAIL': '/var/mail/cltbld', 12:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:01 INFO - 'MOZ_NO_REMOTE': '1', 12:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:01 INFO - 'NO_EM_RESTART': '1', 12:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:45:01 INFO - 'SHELL': '/bin/bash', 12:45:01 INFO - 'SHLVL': '1', 12:45:01 INFO - 'TERM': 'linux', 12:45:01 INFO - 'TMOUT': '86400', 12:45:01 INFO - 'USER': 'cltbld', 12:45:01 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:01 INFO - '_': '/tools/buildbot/bin/python'} 12:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:45:01 INFO - Running setup.py (path:/tmp/pip-cdExOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:45:01 INFO - Running setup.py (path:/tmp/pip-t270AV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:45:02 INFO - Running setup.py (path:/tmp/pip-CDoaXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:45:02 INFO - Running setup.py (path:/tmp/pip-hx1Hyh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:45:02 INFO - Running setup.py (path:/tmp/pip-hmp7GD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:45:02 INFO - Running setup.py (path:/tmp/pip-TWturJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:45:02 INFO - Running setup.py (path:/tmp/pip-HVfiaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:45:02 INFO - Running setup.py (path:/tmp/pip-WRzXzN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:45:02 INFO - Running setup.py (path:/tmp/pip-YI9iwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:45:02 INFO - Running setup.py (path:/tmp/pip-2keH3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:45:02 INFO - Running setup.py (path:/tmp/pip-ARejci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:45:02 INFO - Running setup.py (path:/tmp/pip-3Ajl1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:45:02 INFO - Running setup.py (path:/tmp/pip-gv5vfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:45:02 INFO - Running setup.py (path:/tmp/pip-dXMKR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:45:02 INFO - Running setup.py (path:/tmp/pip-8MfobD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:45:02 INFO - Running setup.py (path:/tmp/pip-CeXhvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:45:03 INFO - Running setup.py (path:/tmp/pip-dnhraf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:45:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:45:03 INFO - Running setup.py install for manifestparser 12:45:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Running setup.py install for mozcrash 12:45:03 INFO - Running setup.py install for mozdebug 12:45:03 INFO - Running setup.py install for mozdevice 12:45:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Running setup.py install for mozfile 12:45:03 INFO - Running setup.py install for mozhttpd 12:45:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Running setup.py install for mozinfo 12:45:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Running setup.py install for mozInstall 12:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:45:03 INFO - Running setup.py install for mozleak 12:45:03 INFO - Running setup.py install for mozlog 12:45:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Running setup.py install for moznetwork 12:45:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Running setup.py install for mozprocess 12:45:04 INFO - Running setup.py install for mozprofile 12:45:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Running setup.py install for mozrunner 12:45:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Running setup.py install for mozscreenshot 12:45:04 INFO - Running setup.py install for moztest 12:45:04 INFO - Running setup.py install for mozversion 12:45:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:45:04 INFO - Cleaning up... 12:45:04 INFO - Return code: 0 12:45:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12: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')]} 12:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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', '-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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12: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', '-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 12: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 -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 12:45:04 INFO - Using env: {'DISPLAY': ':0', 12:45:04 INFO - 'HOME': '/home/cltbld', 12:45:04 INFO - 'LANG': 'en_US.UTF-8', 12:45:04 INFO - 'LANGUAGE': 'en_US:en', 12:45:04 INFO - 'LOGNAME': 'cltbld', 12:45:04 INFO - 'MAIL': '/var/mail/cltbld', 12:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:04 INFO - 'MOZ_NO_REMOTE': '1', 12:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:04 INFO - 'NO_EM_RESTART': '1', 12:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:45:04 INFO - 'SHELL': '/bin/bash', 12:45:04 INFO - 'SHLVL': '1', 12:45:04 INFO - 'TERM': 'linux', 12:45:04 INFO - 'TMOUT': '86400', 12:45:04 INFO - 'USER': 'cltbld', 12:45:04 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:04 INFO - '_': '/tools/buildbot/bin/python'} 12:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:45:05 INFO - Running setup.py (path:/tmp/pip-aS1aKb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:45:05 INFO - Running setup.py (path:/tmp/pip-n9jjRu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:45:05 INFO - Running setup.py (path:/tmp/pip-Cihkj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:45:05 INFO - Running setup.py (path:/tmp/pip-9VjIcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:45:05 INFO - Running setup.py (path:/tmp/pip-Kn6HAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:45:05 INFO - Running setup.py (path:/tmp/pip-Dme49z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:45:05 INFO - Running setup.py (path:/tmp/pip-Gh3Tva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:45:05 INFO - Running setup.py (path:/tmp/pip-_kkxUj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:45:05 INFO - Running setup.py (path:/tmp/pip-N5x4H8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:45:05 INFO - Running setup.py (path:/tmp/pip-DV_9NI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:45:05 INFO - Running setup.py (path:/tmp/pip-qKExMN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:45:05 INFO - Running setup.py (path:/tmp/pip-0QJHE7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:45:05 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)) 12:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:45:05 INFO - Running setup.py (path:/tmp/pip-ZlFsVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:45:06 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)) 12:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:45:06 INFO - Running setup.py (path:/tmp/pip-v4X5yU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:45:06 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)) 12:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:45:06 INFO - Running setup.py (path:/tmp/pip-QWGE7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:45:06 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)) 12:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:45:06 INFO - Running setup.py (path:/tmp/pip-U67L9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:45:06 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)) 12:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:45:06 INFO - Running setup.py (path:/tmp/pip-OzTrlg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:45:06 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)) 12:45:06 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)) 12:45:06 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)) 12:45:06 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)) 12:45:06 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)) 12:45:06 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)) 12:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12: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 12: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 12: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 12: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 12: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 12: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 12:45:07 INFO - Downloading blessings-1.5.1.tar.gz 12:45:07 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 12:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:45:08 INFO - Installing collected packages: blessings 12:45:08 INFO - Running setup.py install for blessings 12:45:08 INFO - Successfully installed blessings 12:45:08 INFO - Cleaning up... 12:45:08 INFO - Return code: 0 12:45:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:45:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:45:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:45:08 INFO - Reading from file tmpfile_stdout 12:45:08 INFO - Current package versions: 12:45:08 INFO - argparse == 1.2.1 12:45:08 INFO - blessings == 1.5.1 12:45:08 INFO - blobuploader == 1.2.4 12:45:08 INFO - docopt == 0.6.1 12:45:08 INFO - manifestparser == 1.1 12:45:08 INFO - mozInstall == 1.12 12:45:08 INFO - mozcrash == 0.16 12:45:08 INFO - mozdebug == 0.1 12:45:08 INFO - mozdevice == 0.47 12:45:08 INFO - mozfile == 1.2 12:45:08 INFO - mozhttpd == 0.7 12:45:08 INFO - mozinfo == 0.9 12:45:08 INFO - mozleak == 0.1 12:45:08 INFO - mozlog == 3.1 12:45:08 INFO - moznetwork == 0.27 12:45:08 INFO - mozprocess == 0.22 12:45:08 INFO - mozprofile == 0.28 12:45:08 INFO - mozrunner == 6.11 12:45:08 INFO - mozscreenshot == 0.1 12:45:08 INFO - mozsystemmonitor == 0.0 12:45:08 INFO - moztest == 0.7 12:45:08 INFO - mozversion == 1.4 12:45:08 INFO - psutil == 3.1.1 12:45:08 INFO - requests == 1.2.3 12:45:08 INFO - wsgiref == 0.1.2 12:45:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:08 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:45:08 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 12:45:08 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 12:45:08 INFO - Using env: {'DISPLAY': ':0', 12:45:08 INFO - 'HOME': '/home/cltbld', 12:45:08 INFO - 'LANG': 'en_US.UTF-8', 12:45:08 INFO - 'LANGUAGE': 'en_US:en', 12:45:08 INFO - 'LOGNAME': 'cltbld', 12:45:08 INFO - 'MAIL': '/var/mail/cltbld', 12:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:08 INFO - 'MOZ_NO_REMOTE': '1', 12:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:08 INFO - 'NO_EM_RESTART': '1', 12:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:45:08 INFO - 'SHELL': '/bin/bash', 12:45:08 INFO - 'SHLVL': '1', 12:45:08 INFO - 'TERM': 'linux', 12:45:08 INFO - 'TMOUT': '86400', 12:45:08 INFO - 'USER': 'cltbld', 12:45:08 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:08 INFO - '_': '/tools/buildbot/bin/python'} 12:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 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)) 12:45:08 INFO - Cleaning up... 12:45:08 INFO - Return code: 0 12:45:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:08 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:45:08 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 12:45:08 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 12:45:08 INFO - Using env: {'DISPLAY': ':0', 12:45:08 INFO - 'HOME': '/home/cltbld', 12:45:08 INFO - 'LANG': 'en_US.UTF-8', 12:45:08 INFO - 'LANGUAGE': 'en_US:en', 12:45:08 INFO - 'LOGNAME': 'cltbld', 12:45:08 INFO - 'MAIL': '/var/mail/cltbld', 12:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:08 INFO - 'MOZ_NO_REMOTE': '1', 12:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:08 INFO - 'NO_EM_RESTART': '1', 12:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:45:08 INFO - 'SHELL': '/bin/bash', 12:45:08 INFO - 'SHLVL': '1', 12:45:08 INFO - 'TERM': 'linux', 12:45:08 INFO - 'TMOUT': '86400', 12:45:08 INFO - 'USER': 'cltbld', 12:45:08 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:08 INFO - '_': '/tools/buildbot/bin/python'} 12:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:08 INFO - Downloading/unpacking jsonschema 12:45:08 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 12:45:08 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 12:45:08 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 12:45:08 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 12:45:08 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 12:45:08 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 12:45:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:45:10 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 12:45:10 INFO - Downloading/unpacking functools32 (from jsonschema) 12:45:10 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 12:45:10 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 12:45:10 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 12:45:10 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 12:45:10 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 12:45:10 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 12:45:10 INFO - Downloading functools32-3.2.3-2.tar.gz 12:45:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:45:10 INFO - warning: no files found matching '*.txt' 12:45:10 INFO - no previously-included directories found matching 'build' 12:45:10 INFO - no previously-included directories found matching 'dist' 12:45:10 INFO - no previously-included directories found matching '.git*' 12:45:10 INFO - Installing collected packages: jsonschema, functools32 12:45:10 INFO - Running setup.py install for functools32 12:45:10 INFO - warning: no files found matching '*.txt' 12:45:10 INFO - no previously-included directories found matching 'build' 12:45:10 INFO - no previously-included directories found matching 'dist' 12:45:10 INFO - no previously-included directories found matching '.git*' 12:45:10 INFO - Successfully installed jsonschema functools32 12:45:10 INFO - Cleaning up... 12:45:11 INFO - Return code: 0 12:45:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:45:11 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')]} 12:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:11 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')]} 12:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:11 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 0x7ffca2ef9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, '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': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', '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 12:45:11 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 12:45:11 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 12:45:11 INFO - Using env: {'DISPLAY': ':0', 12:45:11 INFO - 'HOME': '/home/cltbld', 12:45:11 INFO - 'LANG': 'en_US.UTF-8', 12:45:11 INFO - 'LANGUAGE': 'en_US:en', 12:45:11 INFO - 'LOGNAME': 'cltbld', 12:45:11 INFO - 'MAIL': '/var/mail/cltbld', 12:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:11 INFO - 'MOZ_NO_REMOTE': '1', 12:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:11 INFO - 'NO_EM_RESTART': '1', 12:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:45:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:45:11 INFO - 'SHELL': '/bin/bash', 12:45:11 INFO - 'SHLVL': '1', 12:45:11 INFO - 'TERM': 'linux', 12:45:11 INFO - 'TMOUT': '86400', 12:45:11 INFO - 'USER': 'cltbld', 12:45:11 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:11 INFO - '_': '/tools/buildbot/bin/python'} 12:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:11 INFO - Downloading/unpacking flake8 12: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 12: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 12: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 12: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 12: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 12: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 12:45:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:45:12 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 12:45:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:45:12 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 12:45:12 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 12:45:12 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 12:45:12 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 12:45:12 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 12:45:12 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 12:45:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:45:13 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 12:45:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 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 12:45:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:45:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:13 INFO - no previously-included directories found matching 'docs/_build' 12:45:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:45:13 INFO - Running setup.py install for pep8 12:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:13 INFO - no previously-included directories found matching 'docs/_build' 12:45:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:45:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:45:13 INFO - Cleaning up... 12:45:13 INFO - Return code: 0 12:45:13 INFO - Running post-action listener: _resource_record_post_action 12:45:13 INFO - Running post-action listener: _start_resource_monitoring 12:45:13 INFO - Starting resource monitoring. 12:45:13 INFO - ##### 12:45:13 INFO - ##### Running install step. 12:45:13 INFO - ##### 12:45:13 INFO - Running pre-action listener: _resource_record_pre_action 12:45:13 INFO - Running main action method: install 12:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:45:13 INFO - Reading from file tmpfile_stdout 12:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 12:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:45:14 INFO - Reading from file tmpfile_stdout 12:45:14 INFO - Output received: 12:45:14 INFO - Usage: mozinstall [options] installer 12:45:14 INFO - Options: 12:45:14 INFO - -h, --help show this help message and exit 12:45:14 INFO - -d DEST, --destination=DEST 12:45:14 INFO - Directory to install application into. [default: 12:45:14 INFO - "/builds/slave/test-pgo"] 12:45:14 INFO - --app=APP Application being installed. [default: firefox] 12:45:14 INFO - mkdir: /builds/slave/test-pgo/build/application 12:45:14 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'] 12:45:14 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 12:45:29 INFO - Reading from file tmpfile_stdout 12:45:29 INFO - Output received: 12:45:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:45:29 INFO - Running post-action listener: _resource_record_post_action 12:45:29 INFO - ##### 12:45:29 INFO - ##### Running run-tests step. 12:45:29 INFO - ##### 12:45:29 INFO - Running pre-action listener: _resource_record_pre_action 12:45:29 INFO - Running main action method: run_tests 12:45:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:45:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:45:29 INFO - Python 2.7.3 12:45:29 INFO - Return code: 0 12:45:29 INFO - grabbing minidump binary from tooltool 12:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:29 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 0x1329660>, '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 0x132a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132aa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:45:29 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 12:45:29 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 12:45:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:45:29 INFO - Return code: 0 12:45:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:45:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:45:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:45:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:45:30 INFO - Return code: 0 12:45:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 12:45:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 12:45:30 INFO - Using env: {'DISPLAY': ':0', 12:45:30 INFO - 'HOME': '/home/cltbld', 12:45:30 INFO - 'LANG': 'en_US.UTF-8', 12:45:30 INFO - 'LANGUAGE': 'en_US:en', 12:45:30 INFO - 'LOGNAME': 'cltbld', 12:45:30 INFO - 'MAIL': '/var/mail/cltbld', 12:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:30 INFO - 'MOZ_NO_REMOTE': '1', 12:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:30 INFO - 'NO_EM_RESTART': '1', 12:45:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:45:30 INFO - 'PWD': '/builds/slave/test-pgo', 12:45:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:45:30 INFO - 'SHELL': '/bin/bash', 12:45:30 INFO - 'SHLVL': '1', 12:45:30 INFO - 'TERM': 'linux', 12:45:30 INFO - 'TMOUT': '86400', 12:45:30 INFO - 'USER': 'cltbld', 12:45:30 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049', 12:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:30 INFO - '_': '/tools/buildbot/bin/python'} 12:45:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:45:31 INFO - mozversion application_buildid: 20151222103016 12:45:31 INFO - mozversion application_changeset: 74d2f955790a65ffd4a11075b08937536cfc5272 12:45:31 INFO - mozversion application_display_name: Nightly 12:45:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:45:31 INFO - mozversion application_name: Firefox 12:45:31 INFO - mozversion application_remotingname: firefox 12:45:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:45:31 INFO - mozversion application_vendor: Mozilla 12:45:31 INFO - mozversion application_version: 46.0a1 12:45:31 INFO - mozversion platform_buildid: 20151222103016 12:45:31 INFO - mozversion platform_changeset: 74d2f955790a65ffd4a11075b08937536cfc5272 12:45:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:45:31 INFO - mozversion platform_version: 46.0a1 12:45:31 INFO - using testdate: 1450817131 12:45:31 INFO - actual date: 1450817131 12:45:31 INFO - starting webserver on 'localhost:54127' 12:45:31 INFO - SUITE-START | Running 3 tests 12:45:31 INFO - TEST-START | dromaeo_css 12:45:31 INFO - operating with platform_type : linux_ 12:45:31 INFO - Initialising browser for dromaeo_css test... 12:45:31 INFO - TEST-INFO | started process 23985 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpknxcXd/profile http://localhost:54127/getInfo.html) 12:45:35 INFO - PROCESS | 23985 | __metrics Screen width/height:1600/1200 12:45:35 INFO - PROCESS | 23985 | colorDepth:24 12:45:35 INFO - PROCESS | 23985 | Browser inner width/height: 1024/697 12:45:35 INFO - PROCESS | 23985 | __metrics 12:45:35 INFO - PROCESS | 23985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:45:35 INFO - PROCESS | 23985 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:45:36 INFO - TEST-INFO | 23985: exit 0 12:45:36 INFO - Browser initialized. 12:45:36 INFO - Running cycle 1/1 for dromaeo_css test... 12:45:36 INFO - TEST-INFO | started process 24080 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpknxcXd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:48 INFO - PROCESS | 24080 | RSS: Main: 149282816 12:45:48 INFO - PROCESS | 24080 | 12:46:39 INFO - PROCESS | 24080 | 1450817199715 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] 12:48:48 INFO - PROCESS | 24080 | Cycle 1(1): loaded http://localhost:54127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54127/tests/dromaeo/cssquery-ext.html) 12:48:49 INFO - PROCESS | 24080 | RSS: Main: 257662976 12:48:49 INFO - PROCESS | 24080 | 12:51:52 INFO - PROCESS | 24080 | Cycle 1(1): loaded http://localhost:54127/tests/dromaeo/cssquery-ext.html (next: http://localhost:54127/tests/dromaeo/cssquery-jquery.html) 12:51:52 INFO - PROCESS | 24080 | RSS: Main: 230604800 12:51:52 INFO - PROCESS | 24080 | 12:54:54 INFO - PROCESS | 24080 | Cycle 1(1): loaded http://localhost:54127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54127/tests/dromaeo/cssquery-mootools.html) 12:54:55 INFO - PROCESS | 24080 | RSS: Main: 227586048 12:54:55 INFO - PROCESS | 24080 | 12:57:57 INFO - PROCESS | 24080 | Cycle 1(1): loaded http://localhost:54127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54127/tests/dromaeo/cssquery-prototype.html) 12:57:57 INFO - PROCESS | 24080 | RSS: Main: 211120128 12:57:57 INFO - PROCESS | 24080 | 13:01:00 INFO - PROCESS | 24080 | Cycle 1(1): loaded http://localhost:54127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54127/tests/dromaeo/cssquery-yui.html) 13:01:00 INFO - PROCESS | 24080 | RSS: Main: 215326720 13:01:00 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | Cycle 1(1): loaded http://localhost:54127/tests/dromaeo/cssquery-yui.html (next: http://localhost:54127/tests/dromaeo/cssquery-dojo.html) 13:04:03 INFO - PROCESS | 24080 | RSS: Main: 258260992 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | __start_tp_report 13:04:03 INFO - PROCESS | 24080 | _x_x_mozilla_page_load 13:04:03 INFO - PROCESS | 24080 | _x_x_mozilla_page_load_details 13:04:03 INFO - PROCESS | 24080 | |i|pagename|runs| 13:04:03 INFO - PROCESS | 24080 | |0;dojo.html;3066.6166729158854;3166.7783255172117;3200.103970888151;3202.711755941966;3234.126785767842;5137.255098010795;5174.430812610614;5236.502532259429;5292.060421162288;5345.839624811257;5130.127878260695;5133.974330128353;5192.818251361203;5197.974010129953;5212.244224587442;4802.543758342952;4839.177339852234;4858.41698996121;4918.754062296889;4926.433460152092;4681.625469962395;4896.069746748107;4920.852374428773;4947.604191664658;4987.451380348159;4681.765911704419;4804.327394164819;4885.120678277908;4885.340479035321;4889.8777530561665;4835.1296766582;4851.805927762885;4852.344933433977;4858.659893807435;4903.8528844134735;4630.536946305376;4822.758862056883;4829.348038014893;4831.685940413862;4893.241547560134;5022.874428139326;5056.266841308026;5084.262781896604;5087.058894104565;5088.592912567023;5620.241267428885;5632.746526406321;5634.690092044936;5639.323281206241;5640.182173584848;5598.076317407623;5657.1514272858985;5682.886342273173;5697.572682048863;5698.173764804122;5148.84553463393;5383.838484845461;5385.7307134643115;5391.514763671288;5437.211604317352;5753.539716822645;5821.446962538552;5869.735861886225;5884.9705751470965;5932.288125424977;5425.565954723613;5512.062949298629;5527.972360138174;5535.418781027934;5620.887582248332;5598.10430331145;5612.579056570774;5618.2415373924;5625.774969001276;5660.179274005246;5637.830865074055;5641.943580564224;5650.0959846424375;5658.603897727119;5685.658860468385;5425.267588875451;5541.168824676251;5542.168674698827;5555.527780138734;5643.830685079454;4353.25994580922;4400.559944005638;4406.603405693503;4418.33724941255;4451.376807246988;3943.842246310173;3944.1125746707335;3954.367301231789;3958.5843486434087;3985.70107241958;5134.717590532482;5243.370795504564;5247.868803279872;5322.467753224647;5351.732413379315;5541.889162216733;5574.303212098488;5640.294963129609;5643.887122257532;5665.065264231438;5210.505002024802;5270.420253772082;5273.841784746463;5277.630565860353;5329;4784.545468180518;4861.513848615181;4873.269009648581;4886.657933944661;4905.877353066202;5775.826725198251;5856.882862342814;5858.882822343529;5860.120981852756;5909.852253693692;5648.971755141198;5650.23721797552;5663.263775709132;5663.631863928831;5664.915026274692;5717.742701578356;5818.156367326798;5833.67914764692;5838.299404071538;5875.853103672272;5606.215129881902;5613.578981576316;5618.606697531297;5620.803271885465;5621.269234999424;5634.661920284796;5664.943350566607;5722.828315150552;5724.313082430135;5725.0267454531995;5570;5628.352739435018;5632.239647647679;5634.7464364104535;5635.042042852643;5608.523275521627;5611.663300202001;5613.943860561342;5615.7192140392;5621.74702138413;5259.815906443256;5371.543418809445;5374.48942350476;5393.487618676219;5488.917666235089;5553.333599968029;5591.580631452739;5594.049011668108;5643.181738647955;5655.4344565543115;5433.972830135824;5473.2063850742215;5476.2333273342565;5477.698726570077;5489.066858633962 13:04:03 INFO - PROCESS | 24080 | |1;ext.html;565.8778527281343;594.0317282828988;598.2850493660078;599.6551982609999;601.143370696757;30465.69534304659;31736;39773.602263977315;40327;40337;43971.34042989358;44372.3344149838;44478.55521444784;44498;44527.77736111315;8814.250788682953;8977.326700497457;8986.191242788147;8986.86519702205;8988.505632190227;7779;7959.840803183933;10526.210534209926;10806.837897431546;10830.566777328937;10460.163186945027;10520.368777873315;10552.577896884115;10561.155107591374;10563.313384630013;7838.647260873275;10511;10600.522976466078;10605.84091238632;10625.096866766335;7716.074071111502;10659.467026648714;10889.564417423373;10937.617183398543;10953.507092180871;41785.791071044754;42146.15707685829;42174.78912605448;42233.366499502226;42322.365164522555;3401.9319613607836;3432.5022871683714;3442;3443.380191565542;3467.6532346765375;30809.075727728203;31291.53062704061;31297.687023129933;31339.686603133905;31693.84153079243;3517.314123745871;3537.204129070964;3566.5185199997927;3650.0327413235514;3709.406494960793;274076;275231;275616.999999998;275889;276165;53975.46024539783;55110;66003;66469.66765166144;66698.33301666922;61705.38294617086;61742.382576173666;61843.6907815458;62036.379636203965;62072.68963655153;13072.150310229805;13206.603801885767;13206.73586528264;13209.537666181637;13211.801822972662;9712.951435242778;9745.902540974499;9790.265730070274;9835.311528192959;9841.065098815601;20475.59048819015;20545.48636284075;20691;20708.792912070687;20727.58544829095;7187;7380.409567234608;7450.217727138681;7486.625668716542;7523.661435235427;888.5868071346855;981.9509024548744;984.0991860534577;1034.8033873564;1105;28683.56974645382;29109.56335654967;29205.269868253465;29531;29665.406691866472;1017.730301470111;1038.6883934819523;1075.930064545802;1118.8545489086366;1150.9353847690852;15191.772123418157;15204.695906081817;15233;15490.690186196212;15541.300641471162;310459;315038;315131;315755;316136;53319;53677.463225368025;53683.731581341846;53738;53780.731096344265;1316.9868301316865;1325.3174615073244;1326.2440408966797;1353.5939218234491;1354.6613346663137;27970.300742481602;28334.71665283403;28921.276968075967;28994.7100528992;29091;47485;47676.761616191696;47869;47928.04143917172;47979.760101199274;294010;296703;298084;298449;299147;27892;28356;31396.529052064696;32164.356712865145;32348.35303293968;38616.42075368928;39863.800680996406;41602.791986039876;42331;42952.35571466368;35085.47371789374;35863.46204806878;36238;36422.4536631956;42848.78575607102;29428.264293392836;39693.80153099216;40867;41190;41734.373984389655;38641.806790965864;39250.41124383079;39736.40395394129;39738;40132.1973560533;39997.20005599813;40431.39352909767;40445.59554404418;40736.3889541663;40926.181476370904;27318;27516.724832752217;27758.44401431624;27947.970574821946;28070.157895263175 13:04:03 INFO - PROCESS | 24080 | |2;jquery.html;367.52038589640523;367.61400529444086;368.3572166569337;368.9907752306192;370.5257270693513;13459.865401345984;13559.32203389829;16462.259198336073;16804.663906721857;17363.999999999985;12090.33503157326;14025.719485610281;14284.857151428483;14362.928185359058;14365.928170359133;5473.343198816147;5586;5608.130739735348;5623.128415095667;5626.409227031164;3948.8815335539834;4064.593540645941;5435.483629055233;5543;5891.145783861338;5928.407159284058;5951.761929522814;5977.133315669225;5978.581499295051;5985.85035374117;5769.394213607553;5955.821325360246;5988.61074030191;5997.580169388145;6010.57925945184;5435;5442.374126975409;5447.918281225785;5452.209429632681;5456.7544460499375;19766.70349944752;19948.60102797936;20173.193072277092;20699.896500517552;20702.068406921724;2049.2212959075455;2201.6587428948537;2218.378853920905;2272.397814579138;2285.1202287119413;12393.62819115428;12464.43910024042;12600.747985040249;12924.483020679161;13047.478100875953;1638.4511188751783;1667.9416220432227;1690.5858064774086;1739.4955462915739;1763.3034951194334;57041.42958570403;57916.71041644765;60670;60845.391546084415;61434;9529.618815247451;9642.325037247465;9744.12302892743;9809.411435313905;9899.604015839286;12674.429650665743;12765.170263932814;12806.295653738947;12807;12810.42353094113;6782.1861376635115;6805.285445028299;6825.55633883796;6839.2818754031105;6853.760118395832;6246.937530624727;6313.526485513605;6333.556651034383;6348.206474190726;6375.394337537927;5834.941650583524;5865.20819689345;5909.054551271776;5962.880742385128;5976.223090998143;1650.6629629999738;1718.8367105124994;1749.4664127441;1784.6073863749955;1817.1368599914936;938.4309831181728;966.429806414219;1003.1573478278135;1015.9949200253951;1058.1429042475465;16562.17189140538;16708;16936.57658558546;17200.225989830487;17337.913310433367;830.4512084961624;920.8204400141908;921.3780698028804;928.9396189247677;975.9121679048919;9270.35107542479;9363.25093992479;9465.43207407544;9503.28725345602;9683.225341972626;509558;516352;517712;521499;526685;43756.78121609372;43818;50459;75361.78311495583;79956.60021699854;1152.815549512074;1153.5904753812445;1192.272713644676;1214.8056310990198;1229.4590380232669;14650.560483185522;15118.470853520514;15161.24193790284;15177.696446071237;15450.690986179989;35231.11922201965;35331.47002795011;35773.821130894175;36076.4588531167;36163.81918090393;46012.53987460083;46566;49369.75315123545;50200.49799502104;52051.21923171231;9091.90908090937;9303.348765586345;9376.531173441164;9804.411735295906;9877.357971731815;16744.162791860115;17170.141492925053;17258.741118882976;17378;17527.912360438117;13768.105073170213;13816.723665526833;14078.788818167532;14089.647758806112;14172.362243698852;13507.594772156852;13599.320033998458;13636.79544806809;14608.342624582132;14660.413583456542;10809.189310801565;14354.928225358806;14522.419103235752;14554.345054472786;15022.474213402478;8152.8369432609825;9195.687197917958;9751.561179746786;9800.068993445611;9918.256130790076;14158.150510969375;14292.785608215678;14387.712245755236;14465.204413757345;14516.491922782652 13:04:03 INFO - PROCESS | 24080 | |3;mootools.html;1307.4181989014892;1721.1824383417877;1748.4579780268118;1775.112443778111;1778.4753497718173;6428.807135785928;7068.540544864587;7234.927650723491;7276.527025743323;7288.67200975956;7234.746783862566;7378.37283830875;7393.926060739391;7396.0754905636795;7408.59252741099;2195.6047911375945;2229.732432108149;2235.105957616958;2236.4073520517077;2240.3838944290287;2256.2103263857684;2284.20052981456;2314.3172764034566;2315.3632750993443;2317.652352147183;2229.2532001779423;2240.484688521641;2253.357793028987;2258.672492488588;2285.051703543036;2192.451887028243;2216.445888527868;2240.3838944290287;2248.651459023854;2248.7526372099137;2230.565039817236;2251.594712951668;2252.6395776675818;2255.0528777913314;2262.321303608911;7317.817054573625;7372.520786148883;7375.18872923978;7384.298491643285;7385.29839665231;4272.957270427287;4350.825966961318;4375.628071613916;4385.627221686129;4387.868363949086;3110.720035196843;3164.9525257121163;3248.0742988248235;3254.3979363817534;3274.214188594744;1122.1023181454884;1128.2046157458972;1129.6385156749843;1160.3791971295316;1162.1980833225048;9984.650537231162;9999.75000624983;10005.04952029556;10011.399316040988;10018.398896066186;4144.91710165801;4161.9375709364385;4212.073343864345;4247.660187185018;4253.064325848309;8544.53005084714;8558.186972237627;8569.657213711507;8570.100139485265;8573.785655358666;4410.25025745624;4441.467023957081;4470.731756094645;4471.910561788811;4478.731276123443;3598.4602309653237;3687.262547490459;3826.445165450994;4024;4024.678025757932;3554.8578056877436;3571.160777217352;3592.5688917329567;3606.1886075632774;3617.2042150726797;1151.6890439581434;1155.2259985809528;1156.525824411987;1156.5489459110954;1156.8727439981594;1286.2411177405188;1291.031726205346;1306.6080175947368;1312.2716892124963;1314.8553659097493;6999.895001574981;7000.824979375557;7023.262557431498;7107.431405487549;7112.92887071133;504.5837184322948;510.4206725366735;514.2235224810563;515.5076901559003;516.3261943164132;5555.472230138131;5593.720313984284;5626.127950167731;5626.971865140648;5633.943660563342;8571.957140214383;8719.12808719123;8744.387892847566;8786.692465763668;8863.157999989991;8664.783380415414;8764.737057888273;8771.079036701181;8792.384533082623;8795.120487951282;6942.895856562156;6975.895361569581;6998.650067496605;7080.371514551579;7081.7167313308955;6723.596584204964;6747.426468750211;6748.763793267212;6752.898706519504;6754.696038678369;7611.124720656974;7907.051153861574;7997.240262175084;8016.599170041592;8049.678012879419;7966.92033079685;8161.469504482189;8186.467879587808;8298.792530186794;8328;5684.3747187808485;6198.504119670506;6442.259140198749;6525.151730275224;6574.572652777554;6922;6924.757633482804;6932.549384290005;6956.0609317741455;6963.721451141898;6348.746050157942;6550.901736473861;6570.5400621957915;6590.9670451647435;6682.231543372574;6519.282878883224;6525.902111468236;6535.44448721864;6573.835654108686;6607.240167380813;6210.3168651449205;6238.563300568917;6241.906371404341;6243.937560624336;6248.375162483715;5700.173474846041;5788.971055144697;5796.94203057964;6010.038393856962;6043.667598281961;6056.152138700673;6104.145419641342;6105;6107.786227482017;6111.572189946839 13:04:03 INFO - PROCESS | 24080 | |4;prototype.html;342.34270201213667;342.979848691209;352.04771094190215;352.6614450127876;356.6772071275493;5963.4334738199805;5968.612040217388;5980.491658209052;5990.251218597676;6014.789482368118;5882.970585147068;5889.7644094236175;5899.88200235995;5900.822975310747;5905.557083218754;4514.616257618107;4576.565226303496;4588;4591.150637132125;4609.124266389375;4626.8149274029165;4627.329037289591;4632.2125238709505;4632.606228470584;4635.768211589424;4571.428571428572;4578.130155270488;4578.885527861797;4584.220682483986;4587.403637527117;4374.846880359188;4461.643068554507;4466.687331886769;4508.436445444319;4568.70303430276;4035.2131334389805;4038.676905847525;4045.1707399982934;4062.6343629073526;4069.9389509157386;5472.863178420532;5616.63491873031;5617.354004289518;5640.0693885508845;5644.774209031675;5193.792248310063;5231.346081739783;5372.811951581676;5375;5382.865428364283;6263.624182549016;6270.247570291549;6279.466245369149;6283.685815709242;6287.497000240016;4502.2796352583755;4505.797239124247;4505.887352816173;4507.684462087655;4513.323001549761;6392.744290228386;6530.346965303479;6537.117489138953;6551.05009773585;6553.508486863504;4657.976710116495;4660.091282200006;4660.161170989254;4661.417322834645;4662.673612847068;4711.905761884743;4714.4342678878065;4717;4718.292256161603;4718.669693121517;5257.605679574047;5353.437889021597;5368.91946620801;5370.91943620846;5371.865703357447;6288.654124023131;6309.779157729457;6321.8735625288155;6328.557001009885;6346.11154438379;1633;1653.0742784040976;1663.7254852949127;1664.6670665866634;1664.891782034164;1140.1562843495753;1140.2531341971023;1142.3260276436943;1160.976780464386;1165.3998190931677;5990.940090599038;5991.161237426763;5993.280806303272;5996.790112346047;6003;6491.318411566717;6497.772577959749;6500.187476565429;6502.577332473374;6521.347865213535;5880.294364676266;5886.470217680344;5889.116632505158;5895.734691938873;5903.321118071391;3449.689527942497;3524.4184709523156;3526.3652542542077;3528.400171970771;3529.294141171776;6786.253512113663;6791;6797.898031529531;6810.489213308922;6818.28408017161;6425.421712045938;6471.158749362553;6535.640539770263;6616.603003819786;6701.865962680719;6764;6773.830654233585;6781.186257649114;6792.76225332111;6800.319968003259;6550.770723024862;6552.6068435894;6560.507961902972;6577;6579.638119903259;6373.426391624776;6489.221293444628;6490.350964903472;6491.350864913471;6496.70764815575;6713.295104014203;6769.796906092825;6782.660866956731;6792.456603471809;6801.625910574966;4445.711028783118;4483.820647174077;4489.0572979674635;4491.124230774967;4497.887552811075;6477.578957367756;6547.672616369257;6581.078648989241;6583.275839657538;6585.5719378240265;6375.107484952017;6389.712462939272;6400.23197216337;6409.391107844747;6410.871782564416;6406;6408.61548307103;6409.455196308366;6412.198475190601;6419.871602568016;6181.533646322408;6273.9372606273355;6288.968555157195;6298.275698294571;6303.149074874833;6367.9044814328745;6391.6804159792755;6412.358764123737;6414.550981431255;6426.614403135827;6224.1597384352535;6229.781957631461;6230.314665386894;6269.373062693694;6278.372162783685 13:04:03 INFO - PROCESS | 24080 | |5;yui.html;773.760134358349;790.841831633673;824.9628766705498;830.5141492227046;845.2181731897997;13693.109947853383;13791.379387927542;13953.09304895181;13983.580492585239;14004;12230.32733199676;12299.754004919896;12324;13263.40314685839;13845.169289842617;679.2053297641746;821.757581513455;846.5428668518992;847.4533925618003;847.474565769224;694.3820000199801;699.2308460693248;699.4823830365518;700.9158900931895;828.5732847583499;874.9825003499926;880.2957633892892;890.461270931087;890.9153630405101;891.2023738753811;882.1046637662778;884.9955750221208;888.5335199020501;888.5646033443599;890.4434728294816;530.4350866327387;533.9813106541252;639.9936000639981;648.2188962300417;649.1009951217551;14000.509982150677;14013.789793153112;14046.92976535121;14057.718845623132;14083;10855.294405863593;11335.206535542515;11516.136289778216;11819.113566482461;12788.48846046157;9844.163246124088;10073.345232559861;10081.747956301078;10361.171106311476;10607.84088238677;3440.638732933056;3466.618671946084;3506.2111025019167;3574.7855128692363;3587.336342776595;48576;49035.26447103296;49363.75318123422;49387.75306123446;49517.25724114177;9093.909060909305;9476.099770521789;9499.43003419797;9670.903290967;9778.804423911482;17578.978417481896;17627;17644;17648.382306619464;17667.646647067242;7276;7335.083114610674;7423.369013633794;7450.85098298031;7677.539347639159;4207.852725154605;4218.0720241546815;4231.7672528010635;4231.851885184004;4290.077633308853;3106.642736085334;3109.5802066720703;3110.6111736032994;3125.343677827682;3136.764742644311;557.5456003357251;578.9826305210851;580.7589850212115;581.4911952041963;582.286698793974;557.6542543622979;673.8180691213345;677.2414895317277;683.3030309084805;689.6999805084804;8516.957415213008;8785.472871627722;8848.11518848123;8907.955460222658;9144;550.5448614989219;567.5856624664018;614.9262088549402;693.1017044947533;719.7804669575725;3794.1842503861803;3892.8442862285756;4047.838086476508;4064.085580744309;4126.5667104953545;59536.404635953084;59626.70186649126;60568.39431605628;60642.696786515786;60665.696671517246;53438.93122137536;53531.73234133804;53585.73207133939;53732;55736.442635573934;47921.28118078232;48877.266840997414;49116.50883491119;49165.26252106221;49498;7994.320482759031;8097.2307630774985;8184.508929464251;8186;8236.711715089943;35878;35918.640813591526;36662.450063248536;36840.44739328966;36859;42808.57191428046;47497.52502474931;47590.76204618955;47712;48468.7576562129;9679.70960871175;9785.31502794826;9858.359206651545;10064.295499314978;10141.391516509033;10896.291741036806;11088.778224435304;11200.383978880915;11261;11334.60328888485;10116.19070474375;10158.08577228053;10305.896941030795;10328.431936243578;10514.211434142317;9925.553350099119;9989.300748947504;10200.591976320864;10413.84379234297;10521.684349469528;9881.160101391175;9979.750506237402;10087.092161705481;10198.898011020092;10257.28199026061;9166.358354915092;9418.62325506972;9427.434353938786;9474.336796424184;9504.762380940532;8439.156084391758;9222;9456.763580910532;9565.767768236574;9589.280803939593 13:04:03 INFO - PROCESS | 24080 | __end_tp_report 13:04:03 INFO - PROCESS | 24080 | __start_cc_report 13:04:03 INFO - PROCESS | 24080 | _x_x_mozilla_cycle_collect,902 13:04:03 INFO - PROCESS | 24080 | __end_cc_report 13:04:03 INFO - PROCESS | 24080 | __startTimestamp1450818243655__endTimestamp 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | ------- Summary: start ------- 13:04:03 INFO - PROCESS | 24080 | Number of tests: 6 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | [#0] dojo.html Cycles:165 Average:5255.87 Median:5473.21 stddev:571.49 (10.4%) stddev-sans-first:546.83 13:04:03 INFO - PROCESS | 24080 | Values: 3066.6 3166.8 3200.1 3202.7 3234.1 5137.3 5174.4 5236.5 5292.1 5345.8 5130.1 5134.0 5192.8 5198.0 5212.2 4802.5 4839.2 4858.4 4918.8 4926.4 4681.6 4896.1 4920.9 4947.6 4987.5 4681.8 4804.3 4885.1 4885.3 4889.9 4835.1 4851.8 4852.3 4858.7 4903.9 4630.5 4822.8 4829.3 4831.7 4893.2 5022.9 5056.3 5084.3 5087.1 5088.6 5620.2 5632.7 5634.7 5639.3 5640.2 5598.1 5657.2 5682.9 5697.6 5698.2 5148.8 5383.8 5385.7 5391.5 5437.2 5753.5 5821.4 5869.7 5885.0 5932.3 5425.6 5512.1 5528.0 5535.4 5620.9 5598.1 5612.6 5618.2 5625.8 5660.2 5637.8 5641.9 5650.1 5658.6 5685.7 5425.3 5541.2 5542.2 5555.5 5643.8 4353.3 4400.6 4406.6 4418.3 4451.4 3943.8 3944.1 3954.4 3958.6 3985.7 5134.7 5243.4 5247.9 5322.5 5351.7 5541.9 5574.3 5640.3 5643.9 5665.1 5210.5 5270.4 5273.8 5277.6 5329.0 4784.5 4861.5 4873.3 4886.7 4905.9 5775.8 5856.9 5858.9 5860.1 5909.9 5649.0 5650.2 5663.3 5663.6 5664.9 5717.7 5818.2 5833.7 5838.3 5875.9 5606.2 5613.6 5618.6 5620.8 5621.3 5634.7 5664.9 5722.8 5724.3 5725.0 5570.0 5628.4 5632.2 5634.7 5635.0 5608.5 5611.7 5613.9 5615.7 5621.7 5259.8 5371.5 5374.5 5393.5 5488.9 5553.3 5591.6 5594.0 5643.2 5655.4 5434.0 5473.2 5476.2 5477.7 5489.1 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | [#1] ext.html Cycles:180 Average:47393.53 Median:19276.56 stddev:77290.06 (401.0%) stddev-sans-first:77426.91 13:04:03 INFO - PROCESS | 24080 | Values: 565.9 594.0 598.3 599.7 601.1 30465.7 31736.0 39773.6 40327.0 40337.0 43971.3 44372.3 44478.6 44498.0 44527.8 8814.3 8977.3 8986.2 8986.9 8988.5 7779.0 7959.8 10526.2 10806.8 10830.6 10460.2 10520.4 10552.6 10561.2 10563.3 7838.6 10511.0 10600.5 10605.8 10625.1 7716.1 10659.5 10889.6 10937.6 10953.5 41785.8 42146.2 42174.8 42233.4 42322.4 3401.9 3432.5 3442.0 3443.4 3467.7 30809.1 31291.5 31297.7 31339.7 31693.8 3517.3 3537.2 3566.5 3650.0 3709.4 274076.0 275231.0 275617.0 275889.0 276165.0 53975.5 55110.0 66003.0 66469.7 66698.3 61705.4 61742.4 61843.7 62036.4 62072.7 13072.2 13206.6 13206.7 13209.5 13211.8 9713.0 9745.9 9790.3 9835.3 9841.1 20475.6 20545.5 20691.0 20708.8 20727.6 7187.0 7380.4 7450.2 7486.6 7523.7 888.6 982.0 984.1 1034.8 1105.0 28683.6 29109.6 29205.3 29531.0 29665.4 1017.7 1038.7 1075.9 1118.9 1150.9 15191.8 15204.7 15233.0 15490.7 15541.3 310459.0 315038.0 315131.0 315755.0 316136.0 53319.0 53677.5 53683.7 53738.0 53780.7 1317.0 1325.3 1326.2 1353.6 1354.7 27970.3 28334.7 28921.3 28994.7 29091.0 47485.0 47676.8 47869.0 47928.0 47979.8 294010.0 296703.0 298084.0 298449.0 299147.0 27892.0 28356.0 31396.5 32164.4 32348.4 38616.4 39863.8 41602.8 42331.0 42952.4 35085.5 35863.5 36238.0 36422.5 42848.8 29428.3 39693.8 40867.0 41190.0 41734.4 38641.8 39250.4 39736.4 39738.0 40132.2 39997.2 40431.4 40445.6 40736.4 40926.2 27318.0 27516.7 27758.4 27948.0 28070.2 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | [#2] jquery.html Cycles:180 Average:27662.43 Median:368.67 stddev:84483.88 (22915.6%) stddev-sans-first:84696.02 13:04:03 INFO - PROCESS | 24080 | Values: 367.5 367.6 368.4 369.0 370.5 13459.9 13559.3 16462.3 16804.7 17364.0 12090.3 14025.7 14284.9 14362.9 14365.9 5473.3 5586.0 5608.1 5623.1 5626.4 3948.9 4064.6 5435.5 5543.0 5891.1 5928.4 5951.8 5977.1 5978.6 5985.9 5769.4 5955.8 5988.6 5997.6 6010.6 5435.0 5442.4 5447.9 5452.2 5456.8 19766.7 19948.6 20173.2 20699.9 20702.1 2049.2 2201.7 2218.4 2272.4 2285.1 12393.6 12464.4 12600.7 12924.5 13047.5 1638.5 1667.9 1690.6 1739.5 1763.3 57041.4 57916.7 60670.0 60845.4 61434.0 9529.6 9642.3 9744.1 9809.4 9899.6 12674.4 12765.2 12806.3 12807.0 12810.4 6782.2 6805.3 6825.6 6839.3 6853.8 6246.9 6313.5 6333.6 6348.2 6375.4 5834.9 5865.2 5909.1 5962.9 5976.2 1650.7 1718.8 1749.5 1784.6 1817.1 938.4 966.4 1003.2 1016.0 1058.1 16562.2 16708.0 16936.6 17200.2 17337.9 830.5 920.8 921.4 928.9 975.9 9270.4 9363.3 9465.4 9503.3 9683.2 509558.0 516352.0 517712.0 521499.0 526685.0 43756.8 43818.0 50459.0 75361.8 79956.6 1152.8 1153.6 1192.3 1214.8 1229.5 14650.6 15118.5 15161.2 15177.7 15450.7 35231.1 35331.5 35773.8 36076.5 36163.8 46012.5 46566.0 49369.8 50200.5 52051.2 9091.9 9303.3 9376.5 9804.4 9877.4 16744.2 17170.1 17258.7 17378.0 17527.9 13768.1 13816.7 14078.8 14089.6 14172.4 13507.6 13599.3 13636.8 14608.3 14660.4 10809.2 14354.9 14522.4 14554.3 15022.5 8152.8 9195.7 9751.6 9800.1 9918.3 14158.2 14292.8 14387.7 14465.2 14516.5 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | [#3] mootools.html Cycles:180 Average:5154.97 Median:5792.96 stddev:2616.57 (45.2%) stddev-sans-first:2607.93 13:04:03 INFO - PROCESS | 24080 | Values: 1307.4 1721.2 1748.5 1775.1 1778.5 6428.8 7068.5 7234.9 7276.5 7288.7 7234.7 7378.4 7393.9 7396.1 7408.6 2195.6 2229.7 2235.1 2236.4 2240.4 2256.2 2284.2 2314.3 2315.4 2317.7 2229.3 2240.5 2253.4 2258.7 2285.1 2192.5 2216.4 2240.4 2248.7 2248.8 2230.6 2251.6 2252.6 2255.1 2262.3 7317.8 7372.5 7375.2 7384.3 7385.3 4273.0 4350.8 4375.6 4385.6 4387.9 3110.7 3165.0 3248.1 3254.4 3274.2 1122.1 1128.2 1129.6 1160.4 1162.2 9984.7 9999.8 10005.0 10011.4 10018.4 4144.9 4161.9 4212.1 4247.7 4253.1 8544.5 8558.2 8569.7 8570.1 8573.8 4410.3 4441.5 4470.7 4471.9 4478.7 3598.5 3687.3 3826.4 4024.0 4024.7 3554.9 3571.2 3592.6 3606.2 3617.2 1151.7 1155.2 1156.5 1156.5 1156.9 1286.2 1291.0 1306.6 1312.3 1314.9 6999.9 7000.8 7023.3 7107.4 7112.9 504.6 510.4 514.2 515.5 516.3 5555.5 5593.7 5626.1 5627.0 5633.9 8572.0 8719.1 8744.4 8786.7 8863.2 8664.8 8764.7 8771.1 8792.4 8795.1 6942.9 6975.9 6998.7 7080.4 7081.7 6723.6 6747.4 6748.8 6752.9 6754.7 7611.1 7907.1 7997.2 8016.6 8049.7 7966.9 8161.5 8186.5 8298.8 8328.0 5684.4 6198.5 6442.3 6525.2 6574.6 6922.0 6924.8 6932.5 6956.1 6963.7 6348.7 6550.9 6570.5 6591.0 6682.2 6519.3 6525.9 6535.4 6573.8 6607.2 6210.3 6238.6 6241.9 6243.9 6248.4 5700.2 5789.0 5796.9 6010.0 6043.7 6056.2 6104.1 6105.0 6107.8 6111.6 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | [#4] prototype.html Cycles:180 Average:5310.97 Median:5966.02 stddev:1575.75 (26.4%) stddev-sans-first:1535.41 13:04:03 INFO - PROCESS | 24080 | Values: 342.3 343.0 352.0 352.7 356.7 5963.4 5968.6 5980.5 5990.3 6014.8 5883.0 5889.8 5899.9 5900.8 5905.6 4514.6 4576.6 4588.0 4591.2 4609.1 4626.8 4627.3 4632.2 4632.6 4635.8 4571.4 4578.1 4578.9 4584.2 4587.4 4374.8 4461.6 4466.7 4508.4 4568.7 4035.2 4038.7 4045.2 4062.6 4069.9 5472.9 5616.6 5617.4 5640.1 5644.8 5193.8 5231.3 5372.8 5375.0 5382.9 6263.6 6270.2 6279.5 6283.7 6287.5 4502.3 4505.8 4505.9 4507.7 4513.3 6392.7 6530.3 6537.1 6551.1 6553.5 4658.0 4660.1 4660.2 4661.4 4662.7 4711.9 4714.4 4717.0 4718.3 4718.7 5257.6 5353.4 5368.9 5370.9 5371.9 6288.7 6309.8 6321.9 6328.6 6346.1 1633.0 1653.1 1663.7 1664.7 1664.9 1140.2 1140.3 1142.3 1161.0 1165.4 5990.9 5991.2 5993.3 5996.8 6003.0 6491.3 6497.8 6500.2 6502.6 6521.3 5880.3 5886.5 5889.1 5895.7 5903.3 3449.7 3524.4 3526.4 3528.4 3529.3 6786.3 6791.0 6797.9 6810.5 6818.3 6425.4 6471.2 6535.6 6616.6 6701.9 6764.0 6773.8 6781.2 6792.8 6800.3 6550.8 6552.6 6560.5 6577.0 6579.6 6373.4 6489.2 6490.4 6491.4 6496.7 6713.3 6769.8 6782.7 6792.5 6801.6 4445.7 4483.8 4489.1 4491.1 4497.9 6477.6 6547.7 6581.1 6583.3 6585.6 6375.1 6389.7 6400.2 6409.4 6410.9 6406.0 6408.6 6409.5 6412.2 6419.9 6181.5 6273.9 6289.0 6298.3 6303.1 6367.9 6391.7 6412.4 6414.6 6426.6 6224.2 6229.8 6230.3 6269.4 6278.4 13:04:03 INFO - PROCESS | 24080 | 13:04:03 INFO - PROCESS | 24080 | [#5] yui.html Cycles:180 Average:13927.81 Median:53558.73 stddev:16762.16 (31.3%) stddev-sans-first:16780.07 13:04:03 INFO - PROCESS | 24080 | Values: 773.8 790.8 825.0 830.5 845.2 13693.1 13791.4 13953.1 13983.6 14004.0 12230.3 12299.8 12324.0 13263.4 13845.2 679.2 821.8 846.5 847.5 847.5 694.4 699.2 699.5 700.9 828.6 875.0 880.3 890.5 890.9 891.2 882.1 885.0 888.5 888.6 890.4 530.4 534.0 640.0 648.2 649.1 14000.5 14013.8 14046.9 14057.7 14083.0 10855.3 11335.2 11516.1 11819.1 12788.5 9844.2 10073.3 10081.7 10361.2 10607.8 3440.6 3466.6 3506.2 3574.8 3587.3 48576.0 49035.3 49363.8 49387.8 49517.3 9093.9 9476.1 9499.4 9670.9 9778.8 17579.0 17627.0 17644.0 17648.4 17667.6 7276.0 7335.1 7423.4 7450.9 7677.5 4207.9 4218.1 4231.8 4231.9 4290.1 3106.6 3109.6 3110.6 3125.3 3136.8 557.5 579.0 580.8 581.5 582.3 557.7 673.8 677.2 683.3 689.7 8517.0 8785.5 8848.1 8908.0 9144.0 550.5 567.6 614.9 693.1 719.8 3794.2 3892.8 4047.8 4064.1 4126.6 59536.4 59626.7 60568.4 60642.7 60665.7 53438.9 53531.7 53585.7 53732.0 55736.4 47921.3 48877.3 49116.5 49165.3 49498.0 7994.3 8097.2 8184.5 8186.0 8236.7 35878.0 35918.6 36662.5 36840.4 36859.0 42808.6 47497.5 47590.8 47712.0 48468.8 9679.7 9785.3 9858.4 10064.3 10141.4 10896.3 11088.8 11200.4 11261.0 11334.6 10116.2 10158.1 10305.9 10328.4 10514.2 9925.6 9989.3 10200.6 10413.8 10521.7 9881.2 9979.8 10087.1 10198.9 10257.3 9166.4 9418.6 9427.4 9474.3 9504.8 8439.2 9222.0 9456.8 9565.8 9589.3 13:04:03 INFO - PROCESS | 24080 | -------- Summary: end -------- 13:04:03 INFO - PROCESS | 24080 | 13:04:04 INFO - TEST-INFO | 24080: exit 0 13:04:04 INFO - TEST-OK | dromaeo_css | took 1113366ms 13:04:04 INFO - TEST-START | kraken 13:04:04 INFO - operating with platform_type : linux_ 13:04:04 INFO - Initialising browser for kraken test... 13:04:04 INFO - TEST-INFO | started process 24269 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvif3RE/profile http://localhost:54127/getInfo.html) 13:04:08 INFO - PROCESS | 24269 | __metrics Screen width/height:1600/1200 13:04:08 INFO - PROCESS | 24269 | colorDepth:24 13:04:08 INFO - PROCESS | 24269 | Browser inner width/height: 1024/697 13:04:08 INFO - PROCESS | 24269 | __metrics 13:04:08 INFO - PROCESS | 24269 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:04:08 INFO - PROCESS | 24269 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:04:09 INFO - TEST-INFO | 24269: exit 0 13:04:09 INFO - Browser initialized. 13:04:09 INFO - Running cycle 1/1 for kraken test... 13:04:09 INFO - TEST-INFO | started process 24357 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvif3RE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:21 INFO - PROCESS | 24357 | RSS: Main: 150515712 13:04:21 INFO - PROCESS | 24357 | 13:04:23 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54127/tests/kraken/driver.html?testName=audio-beat-detection) 13:04:24 INFO - PROCESS | 24357 | RSS: Main: 185364480 13:04:24 INFO - PROCESS | 24357 | 13:04:27 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54127/tests/kraken/driver.html?testName=audio-dft) 13:04:27 INFO - PROCESS | 24357 | RSS: Main: 177471488 13:04:27 INFO - PROCESS | 24357 | 13:04:30 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54127/tests/kraken/driver.html?testName=audio-fft) 13:04:31 INFO - PROCESS | 24357 | RSS: Main: 160493568 13:04:31 INFO - PROCESS | 24357 | 13:04:33 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54127/tests/kraken/driver.html?testName=audio-oscillator) 13:04:33 INFO - PROCESS | 24357 | RSS: Main: 163340288 13:04:33 INFO - PROCESS | 24357 | 13:04:35 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:04:36 INFO - PROCESS | 24357 | RSS: Main: 165703680 13:04:36 INFO - PROCESS | 24357 | 13:04:39 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54127/tests/kraken/driver.html?testName=imaging-darkroom) 13:04:39 INFO - PROCESS | 24357 | RSS: Main: 165748736 13:04:39 INFO - PROCESS | 24357 | 13:04:43 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54127/tests/kraken/driver.html?testName=imaging-desaturate) 13:04:43 INFO - PROCESS | 24357 | RSS: Main: 166727680 13:04:43 INFO - PROCESS | 24357 | 13:04:46 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54127/tests/kraken/driver.html?testName=json-parse-financial) 13:04:47 INFO - PROCESS | 24357 | RSS: Main: 166469632 13:04:47 INFO - PROCESS | 24357 | 13:04:48 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:04:49 INFO - PROCESS | 24357 | RSS: Main: 176201728 13:04:49 INFO - PROCESS | 24357 | 13:04:51 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:04:51 INFO - PROCESS | 24357 | RSS: Main: 174747648 13:04:51 INFO - PROCESS | 24357 | 13:04:53 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:04:54 INFO - PROCESS | 24357 | RSS: Main: 187265024 13:04:54 INFO - PROCESS | 24357 | 13:04:56 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:04:57 INFO - PROCESS | 24357 | RSS: Main: 192864256 13:04:57 INFO - PROCESS | 24357 | 13:04:59 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:05:00 INFO - PROCESS | 24357 | RSS: Main: 190435328 13:05:00 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | Cycle 1(1): loaded http://localhost:54127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54127/tests/kraken/driver.html?testName=ai-astar) 13:05:02 INFO - PROCESS | 24357 | RSS: Main: 248872960 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | __start_tp_report 13:05:02 INFO - PROCESS | 24357 | _x_x_mozilla_page_load 13:05:02 INFO - PROCESS | 24357 | _x_x_mozilla_page_load_details 13:05:02 INFO - PROCESS | 24357 | |i|pagename|runs| 13:05:02 INFO - PROCESS | 24357 | |0;ai-astar;109;112;104;110;109;112;101;111;108;117 13:05:02 INFO - PROCESS | 24357 | |1;audio-beat-detection;148;126;156;165;126;151;153;123;165;125 13:05:02 INFO - PROCESS | 24357 | |2;audio-dft;160;166;160;160;160;160;159;162;160;160 13:05:02 INFO - PROCESS | 24357 | |3;audio-fft;71;72;77;107;71;78;71;110;91;71 13:05:02 INFO - PROCESS | 24357 | |4;audio-oscillator;93;93;139;92;93;93;137;93;93;141 13:05:02 INFO - PROCESS | 24357 | |5;imaging-gaussian-blur;110;110;109;109;109;110;109;109;110;110 13:05:02 INFO - PROCESS | 24357 | |6;imaging-darkroom;145;145;145;147;145;145;144;146;146;145 13:05:02 INFO - PROCESS | 24357 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;96 13:05:02 INFO - PROCESS | 24357 | |8;json-parse-financial;58;56;57;56;59;57;55;65;54;55 13:05:02 INFO - PROCESS | 24357 | |9;json-stringify-tinderbox;67;67;67;67;68;71;67;67;67;66 13:05:02 INFO - PROCESS | 24357 | |10;stanford-crypto-aes;83;84;84;86;83;84;85;84;84;85 13:05:02 INFO - PROCESS | 24357 | |11;stanford-crypto-ccm;120;124;127;119;122;115;129;115;120;122 13:05:02 INFO - PROCESS | 24357 | |12;stanford-crypto-pbkdf2;139;147;148;146;145;136;141;151;146;137 13:05:02 INFO - PROCESS | 24357 | |13;stanford-crypto-sha256-iterative;65;69;66;66;65;64;65;65;64;65 13:05:02 INFO - PROCESS | 24357 | __end_tp_report 13:05:02 INFO - PROCESS | 24357 | __start_cc_report 13:05:02 INFO - PROCESS | 24357 | _x_x_mozilla_cycle_collect,939 13:05:02 INFO - PROCESS | 24357 | __end_cc_report 13:05:02 INFO - PROCESS | 24357 | __startTimestamp1450818302280__endTimestamp 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | ------- Summary: start ------- 13:05:02 INFO - PROCESS | 24357 | Number of tests: 14 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:4.42 (4.0%) stddev-sans-first:4.69 13:05:02 INFO - PROCESS | 24357 | Values: 109.0 112.0 104.0 110.0 109.0 112.0 101.0 111.0 108.0 117.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:152.00 stddev:17.07 (11.2%) stddev-sans-first:18.03 13:05:02 INFO - PROCESS | 24357 | Values: 148.0 126.0 156.0 165.0 126.0 151.0 153.0 123.0 165.0 125.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.00 stddev:2.00 (1.3%) stddev-sans-first:2.11 13:05:02 INFO - PROCESS | 24357 | Values: 160.0 166.0 160.0 160.0 160.0 160.0 159.0 162.0 160.0 160.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#3] audio-fft Cycles:10 Average:81.90 Median:71.50 stddev:15.33 (21.4%) stddev-sans-first:15.74 13:05:02 INFO - PROCESS | 24357 | Values: 71.0 72.0 77.0 107.0 71.0 78.0 71.0 110.0 91.0 71.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:22.31 (24.0%) stddev-sans-first:23.11 13:05:02 INFO - PROCESS | 24357 | Values: 93.0 93.0 139.0 92.0 93.0 93.0 137.0 93.0 93.0 141.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:05:02 INFO - PROCESS | 24357 | Values: 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 13:05:02 INFO - PROCESS | 24357 | Values: 145.0 145.0 145.0 147.0 145.0 145.0 144.0 146.0 146.0 145.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:05:02 INFO - PROCESS | 24357 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:3.12 (5.5%) stddev-sans-first:3.30 13:05:02 INFO - PROCESS | 24357 | Values: 58.0 56.0 57.0 56.0 59.0 57.0 55.0 65.0 54.0 55.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 13:05:02 INFO - PROCESS | 24357 | Values: 67.0 67.0 67.0 67.0 68.0 71.0 67.0 67.0 67.0 66.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 13:05:02 INFO - PROCESS | 24357 | Values: 83.0 84.0 84.0 86.0 83.0 84.0 85.0 84.0 84.0 85.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.00 stddev:4.57 (3.7%) stddev-sans-first:4.82 13:05:02 INFO - PROCESS | 24357 | Values: 120.0 124.0 127.0 119.0 122.0 115.0 129.0 115.0 120.0 122.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:146.00 stddev:5.04 (3.5%) stddev-sans-first:5.06 13:05:02 INFO - PROCESS | 24357 | Values: 139.0 147.0 148.0 146.0 145.0 136.0 141.0 151.0 146.0 137.0 13:05:02 INFO - PROCESS | 24357 | 13:05:02 INFO - PROCESS | 24357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 13:05:02 INFO - PROCESS | 24357 | Values: 65.0 69.0 66.0 66.0 65.0 64.0 65.0 65.0 64.0 65.0 13:05:02 INFO - PROCESS | 24357 | -------- Summary: end -------- 13:05:02 INFO - PROCESS | 24357 | 13:05:03 INFO - TEST-INFO | 24357: exit 0 13:05:03 INFO - TEST-OK | kraken | took 58762ms 13:05:03 INFO - TEST-START | v8_7 13:05:03 INFO - operating with platform_type : linux_ 13:05:03 INFO - Initialising browser for v8_7 test... 13:05:03 INFO - TEST-INFO | started process 24605 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPVZref/profile http://localhost:54127/getInfo.html) 13:05:07 INFO - PROCESS | 24605 | __metrics Screen width/height:1600/1200 13:05:07 INFO - PROCESS | 24605 | colorDepth:24 13:05:07 INFO - PROCESS | 24605 | Browser inner width/height: 1024/697 13:05:07 INFO - PROCESS | 24605 | __metrics 13:05:07 INFO - PROCESS | 24605 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:05:07 INFO - PROCESS | 24605 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:08 INFO - TEST-INFO | 24605: exit 0 13:05:08 INFO - Browser initialized. 13:05:08 INFO - Running cycle 1/1 for v8_7 test... 13:05:08 INFO - TEST-INFO | started process 24686 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPVZref/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:20 INFO - PROCESS | 24686 | RSS: Main: 149762048 13:05:20 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:54127/tests/v8_7/run.html (next: http://localhost:54127/tests/v8_7/run.html) 13:05:41 INFO - PROCESS | 24686 | RSS: Main: 582090752 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | __start_tp_report 13:05:41 INFO - PROCESS | 24686 | _x_x_mozilla_page_load 13:05:41 INFO - PROCESS | 24686 | _x_x_mozilla_page_load_details 13:05:41 INFO - PROCESS | 24686 | |i|pagename|runs| 13:05:41 INFO - PROCESS | 24686 | |0;Richards;165.8374792703151 13:05:41 INFO - PROCESS | 24686 | |1;DeltaBlue;188.96447467876038 13:05:41 INFO - PROCESS | 24686 | |2;Encrypt;279.09572983533354 13:05:41 INFO - PROCESS | 24686 | |3;Decrypt;5181.347150259067 13:05:41 INFO - PROCESS | 24686 | |4;RayTrace;1078.7486515641856 13:05:41 INFO - PROCESS | 24686 | |5;Earley;777.000777000777 13:05:41 INFO - PROCESS | 24686 | |6;Boyer;12195.121951219513 13:05:41 INFO - PROCESS | 24686 | |7;RegExp;25743.589743589742 13:05:41 INFO - PROCESS | 24686 | |8;Splay;627.3525721455458 13:05:41 INFO - PROCESS | 24686 | |9;NavierStokes;4830.917874396136 13:05:41 INFO - PROCESS | 24686 | __end_tp_report 13:05:41 INFO - PROCESS | 24686 | __startTimestamp1450818341732__endTimestamp 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | ------- Summary: start ------- 13:05:41 INFO - PROCESS | 24686 | Number of tests: 10 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#0] Richards Cycles:1 Average:165.84 Median:165.84 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 165.8 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 189.0 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 279.1 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 5181.3 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 1078.7 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#5] Earley Cycles:1 Average:777.00 Median:777.00 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 777.0 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 12195.1 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 25743.6 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#8] Splay Cycles:1 Average:627.35 Median:627.35 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 627.4 13:05:41 INFO - PROCESS | 24686 | 13:05:41 INFO - PROCESS | 24686 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:05:41 INFO - PROCESS | 24686 | Values: 4830.9 13:05:41 INFO - PROCESS | 24686 | -------- Summary: end -------- 13:05:41 INFO - PROCESS | 24686 | 13:05:42 INFO - TEST-INFO | 24686: exit 0 13:05:42 INFO - TEST-OK | v8_7 | took 39443ms 13:05:42 INFO - SUITE-END | took 1211s 13:05:42 INFO - Completed test suite (00:20:11) 13:05:42 INFO - Working with test: dromaeo_css 13:05:42 INFO - Generating results file: dromaeo_css 13:05:42 INFO - Working with test: kraken 13:05:42 INFO - Generating results file: kraken 13:05:42 INFO - javascript benchmark 13:05:42 INFO - Working with test: v8_7 13:05:42 INFO - Generating results file: v8_7 13:05:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:05:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 13:05:42 INFO - process_Request line: dromaeo_css 6931.15 graph.html#tests=[[72,63,35]] 13:05:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:05:43 INFO - process_Request line: kraken 1491.50 graph.html#tests=[[232,63,35]] 13:05:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:05:43 INFO - process_Request line: v8_7 21070.29 graph.html#tests=[[230,63,35]] 13:05:43 INFO - RETURN: dromaeo_css: 6931.15 13:05:43 INFO - RETURN: kraken: 1491.50 13:05:43 INFO - RETURN: v8_7: 21070.29 13:05:43 INFO - javascript benchmark 13:05:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3066.6166729158854, 3166.7783255172117, 3200.103970888151, 3202.711755941966, 3234.126785767842, 5137.255098010795, 5174.430812610614, 5236.502532259429, 5292.060421162288, 5345.839624811257, 5130.127878260695, 5133.974330128353, 5192.818251361203, 5197.974010129953, 5212.244224587442, 4802.543758342952, 4839.177339852234, 4858.41698996121, 4918.754062296889, 4926.433460152092, 4681.625469962395, 4896.069746748107, 4920.852374428773, 4947.604191664658, 4987.451380348159, 4681.765911704419, 4804.327394164819, 4885.120678277908, 4885.340479035321, 4889.8777530561665, 4835.1296766582, 4851.805927762885, 4852.344933433977, 4858.659893807435, 4903.8528844134735, 4630.536946305376, 4822.758862056883, 4829.348038014893, 4831.685940413862, 4893.241547560134, 5022.874428139326, 5056.266841308026, 5084.262781896604, 5087.058894104565, 5088.592912567023, 5620.241267428885, 5632.746526406321, 5634.690092044936, 5639.323281206241, 5640.182173584848, 5598.076317407623, 5657.1514272858985, 5682.886342273173, 5697.572682048863, 5698.173764804122, 5148.84553463393, 5383.838484845461, 5385.7307134643115, 5391.514763671288, 5437.211604317352, 5753.539716822645, 5821.446962538552, 5869.735861886225, 5884.9705751470965, 5932.288125424977, 5425.565954723613, 5512.062949298629, 5527.972360138174, 5535.418781027934, 5620.887582248332, 5598.10430331145, 5612.579056570774, 5618.2415373924, 5625.774969001276, 5660.179274005246, 5637.830865074055, 5641.943580564224, 5650.0959846424375, 5658.603897727119, 5685.658860468385, 5425.267588875451, 5541.168824676251, 5542.168674698827, 5555.527780138734, 5643.830685079454, 4353.25994580922, 4400.559944005638, 4406.603405693503, 4418.33724941255, 4451.376807246988, 3943.842246310173, 3944.1125746707335, 3954.367301231789, 3958.5843486434087, 3985.70107241958, 5134.717590532482, 5243.370795504564, 5247.868803279872, 5322.467753224647, 5351.732413379315, 5541.889162216733, 5574.303212098488, 5640.294963129609, 5643.887122257532, 5665.065264231438, 5210.505002024802, 5270.420253772082, 5273.841784746463, 5277.630565860353, 5329.0, 4784.545468180518, 4861.513848615181, 4873.269009648581, 4886.657933944661, 4905.877353066202, 5775.826725198251, 5856.882862342814, 5858.882822343529, 5860.120981852756, 5909.852253693692, 5648.971755141198, 5650.23721797552, 5663.263775709132, 5663.631863928831, 5664.915026274692, 5717.742701578356, 5818.156367326798, 5833.67914764692, 5838.299404071538, 5875.853103672272, 5606.215129881902, 5613.578981576316, 5618.606697531297, 5620.803271885465, 5621.269234999424, 5634.661920284796, 5664.943350566607, 5722.828315150552, 5724.313082430135, 5725.0267454531995, 5570.0, 5628.352739435018, 5632.239647647679, 5634.7464364104535, 5635.042042852643, 5608.523275521627, 5611.663300202001, 5613.943860561342, 5615.7192140392, 5621.74702138413, 5259.815906443256, 5371.543418809445, 5374.48942350476, 5393.487618676219, 5488.917666235089, 5553.333599968029, 5591.580631452739, 5594.049011668108, 5643.181738647955, 5655.4344565543115, 5433.972830135824, 5473.2063850742215, 5476.2333273342565, 5477.698726570077, 5489.066858633962], "unit": "score", "name": "dojo.html", "value": 5219.672869004759}, {"lowerIsBetter": false, "replicates": [565.8778527281343, 594.0317282828988, 598.2850493660078, 599.6551982609999, 601.143370696757, 30465.69534304659, 31736.0, 39773.602263977315, 40327.0, 40337.0, 43971.34042989358, 44372.3344149838, 44478.55521444784, 44498.0, 44527.77736111315, 8814.250788682953, 8977.326700497457, 8986.191242788147, 8986.86519702205, 8988.505632190227, 7779.0, 7959.840803183933, 10526.210534209926, 10806.837897431546, 10830.566777328937, 10460.163186945027, 10520.368777873315, 10552.577896884115, 10561.155107591374, 10563.313384630013, 7838.647260873275, 10511.0, 10600.522976466078, 10605.84091238632, 10625.096866766335, 7716.074071111502, 10659.467026648714, 10889.564417423373, 10937.617183398543, 10953.507092180871, 41785.791071044754, 42146.15707685829, 42174.78912605448, 42233.366499502226, 42322.365164522555, 3401.9319613607836, 3432.5022871683714, 3442.0, 3443.380191565542, 3467.6532346765375, 30809.075727728203, 31291.53062704061, 31297.687023129933, 31339.686603133905, 31693.84153079243, 3517.314123745871, 3537.204129070964, 3566.5185199997927, 3650.0327413235514, 3709.406494960793, 274076.0, 275231.0, 275616.999999998, 275889.0, 276165.0, 53975.46024539783, 55110.0, 66003.0, 66469.66765166144, 66698.33301666922, 61705.38294617086, 61742.382576173666, 61843.6907815458, 62036.379636203965, 62072.68963655153, 13072.150310229805, 13206.603801885767, 13206.73586528264, 13209.537666181637, 13211.801822972662, 9712.951435242778, 9745.902540974499, 9790.265730070274, 9835.311528192959, 9841.065098815601, 20475.59048819015, 20545.48636284075, 20691.0, 20708.792912070687, 20727.58544829095, 7187.0, 7380.409567234608, 7450.217727138681, 7486.625668716542, 7523.661435235427, 888.5868071346855, 981.9509024548744, 984.0991860534577, 1034.8033873564, 1105.0, 28683.56974645382, 29109.56335654967, 29205.269868253465, 29531.0, 29665.406691866472, 1017.730301470111, 1038.6883934819523, 1075.930064545802, 1118.8545489086366, 1150.9353847690852, 15191.772123418157, 15204.695906081817, 15233.0, 15490.690186196212, 15541.300641471162, 310459.0, 315038.0, 315131.0, 315755.0, 316136.0, 53319.0, 53677.463225368025, 53683.731581341846, 53738.0, 53780.731096344265, 1316.9868301316865, 1325.3174615073244, 1326.2440408966797, 1353.5939218234491, 1354.6613346663137, 27970.300742481602, 28334.71665283403, 28921.276968075967, 28994.7100528992, 29091.0, 47485.0, 47676.761616191696, 47869.0, 47928.04143917172, 47979.760101199274, 294010.0, 296703.0, 298084.0, 298449.0, 299147.0, 27892.0, 28356.0, 31396.529052064696, 32164.356712865145, 32348.35303293968, 38616.42075368928, 39863.800680996406, 41602.791986039876, 42331.0, 42952.35571466368, 35085.47371789374, 35863.46204806878, 36238.0, 36422.4536631956, 42848.78575607102, 29428.264293392836, 39693.80153099216, 40867.0, 41190.0, 41734.373984389655, 38641.806790965864, 39250.41124383079, 39736.40395394129, 39738.0, 40132.1973560533, 39997.20005599813, 40431.39352909767, 40445.59554404418, 40736.3889541663, 40926.181476370904, 27318.0, 27516.724832752217, 27758.44401431624, 27947.970574821946, 28070.157895263175], "unit": "score", "name": "ext.html", "value": 18991.504720491776}, {"lowerIsBetter": false, "replicates": [367.52038589640523, 367.61400529444086, 368.3572166569337, 368.9907752306192, 370.5257270693513, 13459.865401345984, 13559.32203389829, 16462.259198336073, 16804.663906721857, 17363.999999999985, 12090.33503157326, 14025.719485610281, 14284.857151428483, 14362.928185359058, 14365.928170359133, 5473.343198816147, 5586.0, 5608.130739735348, 5623.128415095667, 5626.409227031164, 3948.8815335539834, 4064.593540645941, 5435.483629055233, 5543.0, 5891.145783861338, 5928.407159284058, 5951.761929522814, 5977.133315669225, 5978.581499295051, 5985.85035374117, 5769.394213607553, 5955.821325360246, 5988.61074030191, 5997.580169388145, 6010.57925945184, 5435.0, 5442.374126975409, 5447.918281225785, 5452.209429632681, 5456.7544460499375, 19766.70349944752, 19948.60102797936, 20173.193072277092, 20699.896500517552, 20702.068406921724, 2049.2212959075455, 2201.6587428948537, 2218.378853920905, 2272.397814579138, 2285.1202287119413, 12393.62819115428, 12464.43910024042, 12600.747985040249, 12924.483020679161, 13047.478100875953, 1638.4511188751783, 1667.9416220432227, 1690.5858064774086, 1739.4955462915739, 1763.3034951194334, 57041.42958570403, 57916.71041644765, 60670.0, 60845.391546084415, 61434.0, 9529.618815247451, 9642.325037247465, 9744.12302892743, 9809.411435313905, 9899.604015839286, 12674.429650665743, 12765.170263932814, 12806.295653738947, 12807.0, 12810.42353094113, 6782.1861376635115, 6805.285445028299, 6825.55633883796, 6839.2818754031105, 6853.760118395832, 6246.937530624727, 6313.526485513605, 6333.556651034383, 6348.206474190726, 6375.394337537927, 5834.941650583524, 5865.20819689345, 5909.054551271776, 5962.880742385128, 5976.223090998143, 1650.6629629999738, 1718.8367105124994, 1749.4664127441, 1784.6073863749955, 1817.1368599914936, 938.4309831181728, 966.429806414219, 1003.1573478278135, 1015.9949200253951, 1058.1429042475465, 16562.17189140538, 16708.0, 16936.57658558546, 17200.225989830487, 17337.913310433367, 830.4512084961624, 920.8204400141908, 921.3780698028804, 928.9396189247677, 975.9121679048919, 9270.35107542479, 9363.25093992479, 9465.43207407544, 9503.28725345602, 9683.225341972626, 509558.0, 516352.0, 517712.0, 521499.0, 526685.0, 43756.78121609372, 43818.0, 50459.0, 75361.78311495583, 79956.60021699854, 1152.815549512074, 1153.5904753812445, 1192.272713644676, 1214.8056310990198, 1229.4590380232669, 14650.560483185522, 15118.470853520514, 15161.24193790284, 15177.696446071237, 15450.690986179989, 35231.11922201965, 35331.47002795011, 35773.821130894175, 36076.4588531167, 36163.81918090393, 46012.53987460083, 46566.0, 49369.75315123545, 50200.49799502104, 52051.21923171231, 9091.90908090937, 9303.348765586345, 9376.531173441164, 9804.411735295906, 9877.357971731815, 16744.162791860115, 17170.141492925053, 17258.741118882976, 17378.0, 17527.912360438117, 13768.105073170213, 13816.723665526833, 14078.788818167532, 14089.647758806112, 14172.362243698852, 13507.594772156852, 13599.320033998458, 13636.79544806809, 14608.342624582132, 14660.413583456542, 10809.189310801565, 14354.928225358806, 14522.419103235752, 14554.345054472786, 15022.474213402478, 8152.8369432609825, 9195.687197917958, 9751.561179746786, 9800.068993445611, 9918.256130790076, 14158.150510969375, 14292.785608215678, 14387.712245755236, 14465.204413757345, 14516.491922782652], "unit": "score", "name": "jquery.html", "value": 8828.036518809116}, {"lowerIsBetter": false, "replicates": [1307.4181989014892, 1721.1824383417877, 1748.4579780268118, 1775.112443778111, 1778.4753497718173, 6428.807135785928, 7068.540544864587, 7234.927650723491, 7276.527025743323, 7288.67200975956, 7234.746783862566, 7378.37283830875, 7393.926060739391, 7396.0754905636795, 7408.59252741099, 2195.6047911375945, 2229.732432108149, 2235.105957616958, 2236.4073520517077, 2240.3838944290287, 2256.2103263857684, 2284.20052981456, 2314.3172764034566, 2315.3632750993443, 2317.652352147183, 2229.2532001779423, 2240.484688521641, 2253.357793028987, 2258.672492488588, 2285.051703543036, 2192.451887028243, 2216.445888527868, 2240.3838944290287, 2248.651459023854, 2248.7526372099137, 2230.565039817236, 2251.594712951668, 2252.6395776675818, 2255.0528777913314, 2262.321303608911, 7317.817054573625, 7372.520786148883, 7375.18872923978, 7384.298491643285, 7385.29839665231, 4272.957270427287, 4350.825966961318, 4375.628071613916, 4385.627221686129, 4387.868363949086, 3110.720035196843, 3164.9525257121163, 3248.0742988248235, 3254.3979363817534, 3274.214188594744, 1122.1023181454884, 1128.2046157458972, 1129.6385156749843, 1160.3791971295316, 1162.1980833225048, 9984.650537231162, 9999.75000624983, 10005.04952029556, 10011.399316040988, 10018.398896066186, 4144.91710165801, 4161.9375709364385, 4212.073343864345, 4247.660187185018, 4253.064325848309, 8544.53005084714, 8558.186972237627, 8569.657213711507, 8570.100139485265, 8573.785655358666, 4410.25025745624, 4441.467023957081, 4470.731756094645, 4471.910561788811, 4478.731276123443, 3598.4602309653237, 3687.262547490459, 3826.445165450994, 4024.0, 4024.678025757932, 3554.8578056877436, 3571.160777217352, 3592.5688917329567, 3606.1886075632774, 3617.2042150726797, 1151.6890439581434, 1155.2259985809528, 1156.525824411987, 1156.5489459110954, 1156.8727439981594, 1286.2411177405188, 1291.031726205346, 1306.6080175947368, 1312.2716892124963, 1314.8553659097493, 6999.895001574981, 7000.824979375557, 7023.262557431498, 7107.431405487549, 7112.92887071133, 504.5837184322948, 510.4206725366735, 514.2235224810563, 515.5076901559003, 516.3261943164132, 5555.472230138131, 5593.720313984284, 5626.127950167731, 5626.971865140648, 5633.943660563342, 8571.957140214383, 8719.12808719123, 8744.387892847566, 8786.692465763668, 8863.157999989991, 8664.783380415414, 8764.737057888273, 8771.079036701181, 8792.384533082623, 8795.120487951282, 6942.895856562156, 6975.895361569581, 6998.650067496605, 7080.371514551579, 7081.7167313308955, 6723.596584204964, 6747.426468750211, 6748.763793267212, 6752.898706519504, 6754.696038678369, 7611.124720656974, 7907.051153861574, 7997.240262175084, 8016.599170041592, 8049.678012879419, 7966.92033079685, 8161.469504482189, 8186.467879587808, 8298.792530186794, 8328.0, 5684.3747187808485, 6198.504119670506, 6442.259140198749, 6525.151730275224, 6574.572652777554, 6922.0, 6924.757633482804, 6932.549384290005, 6956.0609317741455, 6963.721451141898, 6348.746050157942, 6550.901736473861, 6570.5400621957915, 6590.9670451647435, 6682.231543372574, 6519.282878883224, 6525.902111468236, 6535.44448721864, 6573.835654108686, 6607.240167380813, 6210.3168651449205, 6238.563300568917, 6241.906371404341, 6243.937560624336, 6248.375162483715, 5700.173474846041, 5788.971055144697, 5796.94203057964, 6010.038393856962, 6043.667598281961, 6056.152138700673, 6104.145419641342, 6105.0, 6107.786227482017, 6111.572189946839], "unit": "score", "name": "mootools.html", "value": 4241.248185298578}, {"lowerIsBetter": false, "replicates": [342.34270201213667, 342.979848691209, 352.04771094190215, 352.6614450127876, 356.6772071275493, 5963.4334738199805, 5968.612040217388, 5980.491658209052, 5990.251218597676, 6014.789482368118, 5882.970585147068, 5889.7644094236175, 5899.88200235995, 5900.822975310747, 5905.557083218754, 4514.616257618107, 4576.565226303496, 4588.0, 4591.150637132125, 4609.124266389375, 4626.8149274029165, 4627.329037289591, 4632.2125238709505, 4632.606228470584, 4635.768211589424, 4571.428571428572, 4578.130155270488, 4578.885527861797, 4584.220682483986, 4587.403637527117, 4374.846880359188, 4461.643068554507, 4466.687331886769, 4508.436445444319, 4568.70303430276, 4035.2131334389805, 4038.676905847525, 4045.1707399982934, 4062.6343629073526, 4069.9389509157386, 5472.863178420532, 5616.63491873031, 5617.354004289518, 5640.0693885508845, 5644.774209031675, 5193.792248310063, 5231.346081739783, 5372.811951581676, 5375.0, 5382.865428364283, 6263.624182549016, 6270.247570291549, 6279.466245369149, 6283.685815709242, 6287.497000240016, 4502.2796352583755, 4505.797239124247, 4505.887352816173, 4507.684462087655, 4513.323001549761, 6392.744290228386, 6530.346965303479, 6537.117489138953, 6551.05009773585, 6553.508486863504, 4657.976710116495, 4660.091282200006, 4660.161170989254, 4661.417322834645, 4662.673612847068, 4711.905761884743, 4714.4342678878065, 4717.0, 4718.292256161603, 4718.669693121517, 5257.605679574047, 5353.437889021597, 5368.91946620801, 5370.91943620846, 5371.865703357447, 6288.654124023131, 6309.779157729457, 6321.8735625288155, 6328.557001009885, 6346.11154438379, 1633.0, 1653.0742784040976, 1663.7254852949127, 1664.6670665866634, 1664.891782034164, 1140.1562843495753, 1140.2531341971023, 1142.3260276436943, 1160.976780464386, 1165.3998190931677, 5990.940090599038, 5991.161237426763, 5993.280806303272, 5996.790112346047, 6003.0, 6491.318411566717, 6497.772577959749, 6500.187476565429, 6502.577332473374, 6521.347865213535, 5880.294364676266, 5886.470217680344, 5889.116632505158, 5895.734691938873, 5903.321118071391, 3449.689527942497, 3524.4184709523156, 3526.3652542542077, 3528.400171970771, 3529.294141171776, 6786.253512113663, 6791.0, 6797.898031529531, 6810.489213308922, 6818.28408017161, 6425.421712045938, 6471.158749362553, 6535.640539770263, 6616.603003819786, 6701.865962680719, 6764.0, 6773.830654233585, 6781.186257649114, 6792.76225332111, 6800.319968003259, 6550.770723024862, 6552.6068435894, 6560.507961902972, 6577.0, 6579.638119903259, 6373.426391624776, 6489.221293444628, 6490.350964903472, 6491.350864913471, 6496.70764815575, 6713.295104014203, 6769.796906092825, 6782.660866956731, 6792.456603471809, 6801.625910574966, 4445.711028783118, 4483.820647174077, 4489.0572979674635, 4491.124230774967, 4497.887552811075, 6477.578957367756, 6547.672616369257, 6581.078648989241, 6583.275839657538, 6585.5719378240265, 6375.107484952017, 6389.712462939272, 6400.23197216337, 6409.391107844747, 6410.871782564416, 6406.0, 6408.61548307103, 6409.455196308366, 6412.198475190601, 6419.871602568016, 6181.533646322408, 6273.9372606273355, 6288.968555157195, 6298.275698294571, 6303.149074874833, 6367.9044814328745, 6391.6804159792755, 6412.358764123737, 6414.550981431255, 6426.614403135827, 6224.1597384352535, 6229.781957631461, 6230.314665386894, 6269.373062693694, 6278.372162783685], "unit": "score", "name": "prototype.html", "value": 4808.339481203756}, {"lowerIsBetter": false, "replicates": [773.760134358349, 790.841831633673, 824.9628766705498, 830.5141492227046, 845.2181731897997, 13693.109947853383, 13791.379387927542, 13953.09304895181, 13983.580492585239, 14004.0, 12230.32733199676, 12299.754004919896, 12324.0, 13263.40314685839, 13845.169289842617, 679.2053297641746, 821.757581513455, 846.5428668518992, 847.4533925618003, 847.474565769224, 694.3820000199801, 699.2308460693248, 699.4823830365518, 700.9158900931895, 828.5732847583499, 874.9825003499926, 880.2957633892892, 890.461270931087, 890.9153630405101, 891.2023738753811, 882.1046637662778, 884.9955750221208, 888.5335199020501, 888.5646033443599, 890.4434728294816, 530.4350866327387, 533.9813106541252, 639.9936000639981, 648.2188962300417, 649.1009951217551, 14000.509982150677, 14013.789793153112, 14046.92976535121, 14057.718845623132, 14083.0, 10855.294405863593, 11335.206535542515, 11516.136289778216, 11819.113566482461, 12788.48846046157, 9844.163246124088, 10073.345232559861, 10081.747956301078, 10361.171106311476, 10607.84088238677, 3440.638732933056, 3466.618671946084, 3506.2111025019167, 3574.7855128692363, 3587.336342776595, 48576.0, 49035.26447103296, 49363.75318123422, 49387.75306123446, 49517.25724114177, 9093.909060909305, 9476.099770521789, 9499.43003419797, 9670.903290967, 9778.804423911482, 17578.978417481896, 17627.0, 17644.0, 17648.382306619464, 17667.646647067242, 7276.0, 7335.083114610674, 7423.369013633794, 7450.85098298031, 7677.539347639159, 4207.852725154605, 4218.0720241546815, 4231.7672528010635, 4231.851885184004, 4290.077633308853, 3106.642736085334, 3109.5802066720703, 3110.6111736032994, 3125.343677827682, 3136.764742644311, 557.5456003357251, 578.9826305210851, 580.7589850212115, 581.4911952041963, 582.286698793974, 557.6542543622979, 673.8180691213345, 677.2414895317277, 683.3030309084805, 689.6999805084804, 8516.957415213008, 8785.472871627722, 8848.11518848123, 8907.955460222658, 9144.0, 550.5448614989219, 567.5856624664018, 614.9262088549402, 693.1017044947533, 719.7804669575725, 3794.1842503861803, 3892.8442862285756, 4047.838086476508, 4064.085580744309, 4126.5667104953545, 59536.404635953084, 59626.70186649126, 60568.39431605628, 60642.696786515786, 60665.696671517246, 53438.93122137536, 53531.73234133804, 53585.73207133939, 53732.0, 55736.442635573934, 47921.28118078232, 48877.266840997414, 49116.50883491119, 49165.26252106221, 49498.0, 7994.320482759031, 8097.2307630774985, 8184.508929464251, 8186.0, 8236.711715089943, 35878.0, 35918.640813591526, 36662.450063248536, 36840.44739328966, 36859.0, 42808.57191428046, 47497.52502474931, 47590.76204618955, 47712.0, 48468.7576562129, 9679.70960871175, 9785.31502794826, 9858.359206651545, 10064.295499314978, 10141.391516509033, 10896.291741036806, 11088.778224435304, 11200.383978880915, 11261.0, 11334.60328888485, 10116.19070474375, 10158.08577228053, 10305.896941030795, 10328.431936243578, 10514.211434142317, 9925.553350099119, 9989.300748947504, 10200.591976320864, 10413.84379234297, 10521.684349469528, 9881.160101391175, 9979.750506237402, 10087.092161705481, 10198.898011020092, 10257.28199026061, 9166.358354915092, 9418.62325506972, 9427.434353938786, 9474.336796424184, 9504.762380940532, 8439.156084391758, 9222.0, 9456.763580910532, 9565.767768236574, 9589.280803939593], "unit": "score", "name": "yui.html", "value": 6212.0219886954155}], "name": "dromaeo_css", "value": 6931.146608352255}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 110.0, 109.0, 112.0, 101.0, 111.0, 108.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 126.0, 156.0, 165.0, 126.0, 151.0, 153.0, 123.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [160.0, 166.0, 160.0, 160.0, 160.0, 160.0, 159.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 77.0, 107.0, 71.0, 78.0, 71.0, 110.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 92.0, 93.0, 93.0, 137.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 144.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 56.0, 59.0, 57.0, 55.0, 65.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 71.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 86.0, 83.0, 84.0, 85.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 127.0, 119.0, 122.0, 115.0, 129.0, 115.0, 120.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [139.0, 147.0, 148.0, 146.0, 145.0, 136.0, 141.0, 151.0, 146.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 66.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1491.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8374792703151], "unit": "score", "name": "Richards", "value": 212.87106}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [777.000777000777], "unit": "score", "name": "Earley", "value": 857.737881}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [627.3525721455458], "unit": "score", "name": "Splay", "value": 129.89665399999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21070.294516359285}]} 13:05:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21070.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1491.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6931.15"}}} 13:05:43 INFO - Return code: 0 13:05:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:05:43 INFO - # TBPL SUCCESS # 13:05:43 INFO - Running post-action listener: _resource_record_post_action 13:05:43 INFO - Running post-run listener: _resource_record_post_run 13:05:44 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 545775616; Read time: 500; Write time: 632304 13:05:44 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 235044864; Read time: 292; Write time: 372008 13:05:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310730752; Read time: 208; Write time: 260296 13:05:44 INFO - Running post-run listener: _upload_blobber_files 13:05:44 INFO - Blob upload gear active. 13:05:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:05:44 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 13:05:44 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'] 13:05:44 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 13:05:44 INFO - (blobuploader) - INFO - Open directory for files ... 13:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:05:45 INFO - (blobuploader) - INFO - Done attempting. 13:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:05:46 INFO - (blobuploader) - INFO - Done attempting. 13:05:46 INFO - (blobuploader) - INFO - Iteration through files over. 13:05:46 INFO - Return code: 0 13:05:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:05:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:05:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59f303061bcfbdf1eb65e26aabb5e0ac13de6b4cdef53b61363b80725556dc653abab4e3bd41c8065861f1ca64858ad9c27a903e9571e45f5054c5c9322bcf7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d96c5188ba707f218890178a091b8f70f640f024b6f63fdddf96309b7537855aef5b347ce8e3ddf3b7b2d8470205e99c908278c9c6b8e0adf2d51920efa69653"} 13:05:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:05:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:05:46 INFO - Contents: 13:05:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59f303061bcfbdf1eb65e26aabb5e0ac13de6b4cdef53b61363b80725556dc653abab4e3bd41c8065861f1ca64858ad9c27a903e9571e45f5054c5c9322bcf7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d96c5188ba707f218890178a091b8f70f640f024b6f63fdddf96309b7537855aef5b347ce8e3ddf3b7b2d8470205e99c908278c9c6b8e0adf2d51920efa69653"} 13:05:46 INFO - Copying logs to upload dir... 13:05:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.657187 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-22 13:05:46.632255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 13:05:46.635840) ========= 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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59f303061bcfbdf1eb65e26aabb5e0ac13de6b4cdef53b61363b80725556dc653abab4e3bd41c8065861f1ca64858ad9c27a903e9571e45f5054c5c9322bcf7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d96c5188ba707f218890178a091b8f70f640f024b6f63fdddf96309b7537855aef5b347ce8e3ddf3b7b2d8470205e99c908278c9c6b8e0adf2d51920efa69653"} build_url:https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/qSNSP7dwQe-_NgOCDWz2AA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59f303061bcfbdf1eb65e26aabb5e0ac13de6b4cdef53b61363b80725556dc653abab4e3bd41c8065861f1ca64858ad9c27a903e9571e45f5054c5c9322bcf7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d96c5188ba707f218890178a091b8f70f640f024b6f63fdddf96309b7537855aef5b347ce8e3ddf3b7b2d8470205e99c908278c9c6b8e0adf2d51920efa69653"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 13:05:46.660994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:05:46.661362) ========= 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=7d909545e45784438f4e8e36000001b3-1450816976.417103-535627049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:05:46.747843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 13:05:46.748193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 13:05:46.749731) ========= ========= Total master_lag: 0.24 =========