builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1452516810.76 results: success (0) buildid: 20160111023002 builduid: 17bd6765cf3943c49629f703d2febec4 revision: 98d1a38f79a104f137008d29de2f05338b1fc349 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.763316) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.763864) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.764193) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005416 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.793391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.793776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.807232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.807642) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.857220) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.857555) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.858016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.858326) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 04:53:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-11 04:53:31 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.963402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:30.963781) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022267 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.014033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.014424) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98d1a38f79a104f137008d29de2f05338b1fc349 --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/fx-team --rev 98d1a38f79a104f137008d29de2f05338b1fc349 --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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 04:53:31,156 truncating revision to first 12 chars 2016-01-11 04:53:31,156 Setting DEBUG logging. 2016-01-11 04:53:31,156 attempt 1/10 2016-01-11 04:53:31,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98d1a38f79a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 04:53:31,418 unpacking tar archive at: fx-team-98d1a38f79a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.614424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.614825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.625584) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.626037) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:53:31.626585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-11 04:53:31.626934) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:31 INFO - MultiFileLogger online at 20160111 04:53:31 in /builds/slave/test-pgo 04:53:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:53:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:53:31 INFO - {'append_to_log': False, 04:53:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:53:31 INFO - 'blob_upload_branch': 'Fx-Team', 04:53:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:53:31 INFO - 'branch': 'Fx-Team', 04:53:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:31 INFO - 'config_files': ('talos/linux_config.py',), 04:53:31 INFO - 'default_actions': ('clobber', 04:53:31 INFO - 'read-buildbot-config', 04:53:31 INFO - 'download-and-extract', 04:53:31 INFO - 'populate-webroot', 04:53:31 INFO - 'create-virtualenv', 04:53:31 INFO - 'install', 04:53:31 INFO - 'run-tests'), 04:53:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:31 INFO - 'download_minidump_stackwalk': True, 04:53:31 INFO - 'download_symbols': 'ondemand', 04:53:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:31 INFO - 'installer_path': 'installer.exe', 04:53:31 INFO - 'log_level': 'info', 04:53:31 INFO - 'log_name': 'talos', 04:53:31 INFO - 'log_to_console': True, 04:53:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:31 INFO - 'opt_config_files': (), 04:53:31 INFO - 'pip_index': False, 04:53:31 INFO - 'sps_profile': False, 04:53:31 INFO - 'sps_profile_interval': 0, 04:53:31 INFO - 'suite': 'dromaeojs-e10s', 04:53:31 INFO - 'system_bits': '32', 04:53:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:31 INFO - 'title': 'talos-linux64-ix-023', 04:53:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:31 INFO - 'use_talos_json': True, 04:53:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:53:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:31 INFO - 'work_dir': 'build'} 04:53:31 INFO - ##### 04:53:31 INFO - ##### Running clobber step. 04:53:31 INFO - ##### 04:53:31 INFO - Running pre-action listener: _resource_record_pre_action 04:53:31 INFO - Running main action method: clobber 04:53:31 INFO - rmtree: /builds/slave/test-pgo/build 04:53:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:53:32 INFO - Running post-action listener: _resource_record_post_action 04:53:32 INFO - ##### 04:53:32 INFO - ##### Running read-buildbot-config step. 04:53:32 INFO - ##### 04:53:32 INFO - Running pre-action listener: _resource_record_pre_action 04:53:32 INFO - Running main action method: read_buildbot_config 04:53:32 INFO - Using buildbot properties: 04:53:32 INFO - { 04:53:32 INFO - "project": "", 04:53:32 INFO - "product": "firefox", 04:53:32 INFO - "script_repo_revision": "production", 04:53:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:53:32 INFO - "repository": "", 04:53:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:53:32 INFO - "buildid": "20160111023002", 04:53:32 INFO - "pgo_build": "True", 04:53:32 INFO - "basedir": "/builds/slave/test-pgo", 04:53:32 INFO - "buildnumber": 437, 04:53:32 INFO - "slavename": "talos-linux64-ix-023", 04:53:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:53:32 INFO - "platform": "ubuntu64_hw", 04:53:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:53:32 INFO - "branch": "fx-team", 04:53:32 INFO - "repo_path": "integration/fx-team", 04:53:32 INFO - "revision": "98d1a38f79a104f137008d29de2f05338b1fc349", 04:53:32 INFO - "stage_platform": "linux64-pgo", 04:53:32 INFO - "builduid": "17bd6765cf3943c49629f703d2febec4", 04:53:32 INFO - "slavebuilddir": "test" 04:53:32 INFO - } 04:53:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:53:32 INFO - Running post-action listener: _resource_record_post_action 04:53:32 INFO - ##### 04:53:32 INFO - ##### Running download-and-extract step. 04:53:32 INFO - ##### 04:53:32 INFO - Running pre-action listener: _resource_record_pre_action 04:53:32 INFO - Running main action method: download_and_extract 04:53:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:32 INFO - https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/test_packages.json 04:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/test_packages.json 04:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:53:33 INFO - Downloaded 1302 bytes. 04:53:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:53:33 INFO - Using the following test package requirements: 04:53:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'jsshell-linux-x86_64.zip'], 04:53:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:53:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:53:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:33 INFO - https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:35 INFO - Downloaded 24028612 bytes. 04:53:35 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 04:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:53:35 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 04:53:36 INFO - Return code: 0 04:53:36 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 04:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:36 INFO - https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:39 INFO - Downloaded 24028612 bytes. 04:53:39 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 04:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:53:39 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 04:53:40 INFO - Return code: 0 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:42 INFO - Downloaded 11132285 bytes. 04:53:42 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 04:53:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:42 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 04:53:42 INFO - Return code: 0 04:53:42 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')]} 04:53:42 INFO - https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/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 04:53:45 INFO - Downloaded 55918434 bytes. 04:53:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:53:45 INFO - mkdir: /builds/slave/test-pgo/properties 04:53:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:53:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:53:45 INFO - Contents: 04:53:45 INFO - build_url:https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:53:45 INFO - Running post-action listener: _resource_record_post_action 04:53:45 INFO - Running post-action listener: set_extra_try_arguments 04:53:45 INFO - ##### 04:53:45 INFO - ##### Running populate-webroot step. 04:53:45 INFO - ##### 04:53:45 INFO - Running pre-action listener: _resource_record_pre_action 04:53:45 INFO - Running main action method: populate_webroot 04:53:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:45 INFO - '--tppagecycles', 04:53:45 INFO - '7'], 04:53:45 INFO - 'tests': ['tsvgm']}}, 04:53:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:53:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:53:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:53:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'tests': ['damp', 'tps']}, 04:53:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['damp', 'tps']}, 04:53:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:53:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:45 INFO - 'other': {'tests': ['a11yr', 04:53:45 INFO - 'ts_paint', 04:53:45 INFO - 'tpaint', 04:53:45 INFO - 'sessionrestore', 04:53:45 INFO - 'sessionrestore_no_auto_restore']}, 04:53:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['a11yr', 04:53:45 INFO - 'ts_paint', 04:53:45 INFO - 'tpaint', 04:53:45 INFO - 'sessionrestore', 04:53:45 INFO - 'sessionrestore_no_auto_restore']}, 04:53:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['a11yr', 04:53:45 INFO - 'ts_paint', 04:53:45 INFO - 'tpaint', 04:53:45 INFO - 'sessionrestore', 04:53:45 INFO - 'sessionrestore_no_auto_restore']}, 04:53:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['a11yr', 04:53:45 INFO - 'ts_paint', 04:53:45 INFO - 'tpaint', 04:53:45 INFO - 'sessionrestore', 04:53:45 INFO - 'sessionrestore_no_auto_restore']}, 04:53:45 INFO - 'other_l64': {'tests': ['a11yr', 04:53:45 INFO - 'ts_paint', 04:53:45 INFO - 'tpaint', 04:53:45 INFO - 'sessionrestore', 04:53:45 INFO - 'sessionrestore_no_auto_restore']}, 04:53:45 INFO - 'other_nol64': {'tests': ['a11yr', 04:53:45 INFO - 'ts_paint', 04:53:45 INFO - 'tpaint', 04:53:45 INFO - 'sessionrestore', 04:53:45 INFO - 'sessionrestore_no_auto_restore']}, 04:53:45 INFO - 'svgr': {'tests': ['tsvgx', 04:53:45 INFO - 'tsvgr_opacity', 04:53:45 INFO - 'tart', 04:53:45 INFO - 'tscrollx', 04:53:45 INFO - 'cart']}, 04:53:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['tsvgx', 04:53:45 INFO - 'tsvgr_opacity', 04:53:45 INFO - 'tart', 04:53:45 INFO - 'tscrollx', 04:53:45 INFO - 'cart']}, 04:53:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'tests': ['tp5o']}, 04:53:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'talos_options': ['--e10s'], 04:53:45 INFO - 'tests': ['tp5o']}, 04:53:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'talos_options': ['--xperf_path', 04:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:45 INFO - 'tests': ['tp5n']}, 04:53:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:45 INFO - 'talos_options': ['--e10s', 04:53:45 INFO - '--xperf_path', 04:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:45 INFO - 'tests': ['tp5n']}}, 04:53:45 INFO - 'talos.zip': {'path': '', 04:53:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:45 INFO - Running post-action listener: _resource_record_post_action 04:53:45 INFO - ##### 04:53:45 INFO - ##### Running create-virtualenv step. 04:53:45 INFO - ##### 04:53:45 INFO - Running pre-action listener: _resource_record_pre_action 04:53:45 INFO - Running main action method: create_virtualenv 04:53:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:53:45 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 04:53:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:53:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:45 INFO - Using real prefix '/usr' 04:53:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:53:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:48 INFO - Installing pip.................done. 04:53:48 INFO - Return code: 0 04:53:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:48 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:53:48 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 04:53:48 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 04:53:48 INFO - Using env: {'DISPLAY': ':0', 04:53:48 INFO - 'HOME': '/home/cltbld', 04:53:48 INFO - 'LANG': 'en_US.UTF-8', 04:53:48 INFO - 'LANGUAGE': 'en_US:en', 04:53:48 INFO - 'LOGNAME': 'cltbld', 04:53:48 INFO - 'MAIL': '/var/mail/cltbld', 04:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:48 INFO - 'MOZ_NO_REMOTE': '1', 04:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:48 INFO - 'NO_EM_RESTART': '1', 04:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:48 INFO - 'SHELL': '/bin/bash', 04:53:48 INFO - 'SHLVL': '1', 04:53:48 INFO - 'TERM': 'linux', 04:53:48 INFO - 'TMOUT': '86400', 04:53:48 INFO - 'USER': 'cltbld', 04:53:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:48 INFO - '_': '/tools/buildbot/bin/python'} 04:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:48 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 04:53:48 INFO - Cleaning up... 04:53:48 INFO - Return code: 0 04:53:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:48 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:53:48 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 04:53:48 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 04:53:48 INFO - Using env: {'DISPLAY': ':0', 04:53:48 INFO - 'HOME': '/home/cltbld', 04:53:48 INFO - 'LANG': 'en_US.UTF-8', 04:53:48 INFO - 'LANGUAGE': 'en_US:en', 04:53:48 INFO - 'LOGNAME': 'cltbld', 04:53:48 INFO - 'MAIL': '/var/mail/cltbld', 04:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:48 INFO - 'MOZ_NO_REMOTE': '1', 04:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:48 INFO - 'NO_EM_RESTART': '1', 04:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:48 INFO - 'SHELL': '/bin/bash', 04:53:48 INFO - 'SHLVL': '1', 04:53:48 INFO - 'TERM': 'linux', 04:53:48 INFO - 'TMOUT': '86400', 04:53:48 INFO - 'USER': 'cltbld', 04:53:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:48 INFO - '_': '/tools/buildbot/bin/python'} 04:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:48 INFO - Downloading/unpacking psutil>=0.7.1 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:53:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:50 INFO - Installing collected packages: psutil 04:53:50 INFO - Running setup.py install for psutil 04:53:50 INFO - building 'psutil._psutil_linux' extension 04:53:50 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 04:53:50 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 04:53:50 INFO - building 'psutil._psutil_posix' extension 04:53:50 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 04:53:50 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 04:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:50 INFO - Successfully installed psutil 04:53:50 INFO - Cleaning up... 04:53:50 INFO - Return code: 0 04:53:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:50 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:53:50 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 04:53:50 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 04:53:50 INFO - Using env: {'DISPLAY': ':0', 04:53:50 INFO - 'HOME': '/home/cltbld', 04:53:50 INFO - 'LANG': 'en_US.UTF-8', 04:53:50 INFO - 'LANGUAGE': 'en_US:en', 04:53:50 INFO - 'LOGNAME': 'cltbld', 04:53:50 INFO - 'MAIL': '/var/mail/cltbld', 04:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:50 INFO - 'MOZ_NO_REMOTE': '1', 04:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:50 INFO - 'NO_EM_RESTART': '1', 04:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:50 INFO - 'SHELL': '/bin/bash', 04:53:50 INFO - 'SHLVL': '1', 04:53:50 INFO - 'TERM': 'linux', 04:53:50 INFO - 'TMOUT': '86400', 04:53:50 INFO - 'USER': 'cltbld', 04:53:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:50 INFO - '_': '/tools/buildbot/bin/python'} 04:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:53:51 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 04:53:51 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 04:53:51 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 04:53:51 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 04:53:51 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 04:53:51 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 04:53:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:53:52 INFO - Installing collected packages: mozsystemmonitor 04:53:52 INFO - Running setup.py install for mozsystemmonitor 04:53:53 INFO - Successfully installed mozsystemmonitor 04:53:53 INFO - Cleaning up... 04:53:53 INFO - Return code: 0 04:53:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:53: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')]} 04:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', '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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:53: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:53: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 blobuploader==1.2.4 04:53:53 INFO - Using env: {'DISPLAY': ':0', 04:53:53 INFO - 'HOME': '/home/cltbld', 04:53:53 INFO - 'LANG': 'en_US.UTF-8', 04:53:53 INFO - 'LANGUAGE': 'en_US:en', 04:53:53 INFO - 'LOGNAME': 'cltbld', 04:53:53 INFO - 'MAIL': '/var/mail/cltbld', 04:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:53 INFO - 'MOZ_NO_REMOTE': '1', 04:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:53 INFO - 'NO_EM_RESTART': '1', 04:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:53 INFO - 'SHELL': '/bin/bash', 04:53:53 INFO - 'SHLVL': '1', 04:53:53 INFO - 'TERM': 'linux', 04:53:53 INFO - 'TMOUT': '86400', 04:53:53 INFO - 'USER': 'cltbld', 04:53:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:53 INFO - '_': '/tools/buildbot/bin/python'} 04:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:53:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 INFO - Downloading docopt-0.6.1.tar.gz 04:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:55 INFO - Running setup.py install for blobuploader 04:53:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:53:56 INFO - Running setup.py install for requests 04:53:56 INFO - Running setup.py install for docopt 04:53:56 INFO - Successfully installed blobuploader requests docopt 04:53:56 INFO - Cleaning up... 04:53:56 INFO - Return code: 0 04:53:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:53: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')]} 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:56 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:53:56 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 04:53:56 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 04:53:56 INFO - Using env: {'DISPLAY': ':0', 04:53:56 INFO - 'HOME': '/home/cltbld', 04:53:56 INFO - 'LANG': 'en_US.UTF-8', 04:53:56 INFO - 'LANGUAGE': 'en_US:en', 04:53:56 INFO - 'LOGNAME': 'cltbld', 04:53:56 INFO - 'MAIL': '/var/mail/cltbld', 04:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:56 INFO - 'MOZ_NO_REMOTE': '1', 04:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:56 INFO - 'NO_EM_RESTART': '1', 04:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:56 INFO - 'SHELL': '/bin/bash', 04:53:56 INFO - 'SHLVL': '1', 04:53:56 INFO - 'TERM': 'linux', 04:53:56 INFO - 'TMOUT': '86400', 04:53:56 INFO - 'USER': 'cltbld', 04:53:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:56 INFO - '_': '/tools/buildbot/bin/python'} 04:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:53:56 INFO - Running setup.py (path:/tmp/pip-tPLbE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:53:56 INFO - Running setup.py (path:/tmp/pip-SCozKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:53:56 INFO - Running setup.py (path:/tmp/pip-3PIBms-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:53:56 INFO - Running setup.py (path:/tmp/pip-k2iy5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:53:56 INFO - Running setup.py (path:/tmp/pip-WDqlP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:53:57 INFO - Running setup.py (path:/tmp/pip-zt3CLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:53:57 INFO - Running setup.py (path:/tmp/pip-kHp9kV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:53:57 INFO - Running setup.py (path:/tmp/pip-AhOGaE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:53:57 INFO - Running setup.py (path:/tmp/pip-RGa1Im-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:53:57 INFO - Running setup.py (path:/tmp/pip-FtzRm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:53:57 INFO - Running setup.py (path:/tmp/pip-Z6sDmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:53:57 INFO - Running setup.py (path:/tmp/pip-B04REX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:53:57 INFO - Running setup.py (path:/tmp/pip-JIYewV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:53:57 INFO - Running setup.py (path:/tmp/pip-ZMQrNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:53:57 INFO - Running setup.py (path:/tmp/pip-1fn1KW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:53:57 INFO - Running setup.py (path:/tmp/pip-_rr_sR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:53:57 INFO - Running setup.py (path:/tmp/pip-N0gS6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:53:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:57 INFO - Running setup.py install for manifestparser 04:53:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Running setup.py install for mozcrash 04:53:58 INFO - Running setup.py install for mozdebug 04:53:58 INFO - Running setup.py install for mozdevice 04:53:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Running setup.py install for mozfile 04:53:58 INFO - Running setup.py install for mozhttpd 04:53:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Running setup.py install for mozinfo 04:53:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Running setup.py install for mozInstall 04:53:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Running setup.py install for mozleak 04:53:58 INFO - Running setup.py install for mozlog 04:53:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:53:58 INFO - Running setup.py install for moznetwork 04:53:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:53:59 INFO - Running setup.py install for mozprocess 04:53:59 INFO - Running setup.py install for mozprofile 04:53:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:53:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:53:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:53:59 INFO - Running setup.py install for mozrunner 04:53:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:53:59 INFO - Running setup.py install for mozscreenshot 04:53:59 INFO - Running setup.py install for moztest 04:53:59 INFO - Running setup.py install for mozversion 04:53:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:53:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:59 INFO - Cleaning up... 04:53:59 INFO - Return code: 0 04:53:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:53:59 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 04:53:59 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 04:53:59 INFO - Using env: {'DISPLAY': ':0', 04:53:59 INFO - 'HOME': '/home/cltbld', 04:53:59 INFO - 'LANG': 'en_US.UTF-8', 04:53:59 INFO - 'LANGUAGE': 'en_US:en', 04:53:59 INFO - 'LOGNAME': 'cltbld', 04:53:59 INFO - 'MAIL': '/var/mail/cltbld', 04:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:59 INFO - 'MOZ_NO_REMOTE': '1', 04:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:59 INFO - 'NO_EM_RESTART': '1', 04:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:59 INFO - 'SHELL': '/bin/bash', 04:53:59 INFO - 'SHLVL': '1', 04:53:59 INFO - 'TERM': 'linux', 04:53:59 INFO - 'TMOUT': '86400', 04:53:59 INFO - 'USER': 'cltbld', 04:53:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:59 INFO - '_': '/tools/buildbot/bin/python'} 04:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:53:59 INFO - Running setup.py (path:/tmp/pip-ardx3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:53:59 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)) 04:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:53:59 INFO - Running setup.py (path:/tmp/pip-4j3G9Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:00 INFO - Running setup.py (path:/tmp/pip-VBipK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:00 INFO - Running setup.py (path:/tmp/pip-lxwY55-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:00 INFO - Running setup.py (path:/tmp/pip-7mQet5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:00 INFO - Running setup.py (path:/tmp/pip-TFRAgA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:00 INFO - Running setup.py (path:/tmp/pip-TK5cKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:00 INFO - Running setup.py (path:/tmp/pip-x_xC4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:00 INFO - Running setup.py (path:/tmp/pip-jOte16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:00 INFO - Running setup.py (path:/tmp/pip-49WDyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:00 INFO - Running setup.py (path:/tmp/pip-TpRQMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:00 INFO - Running setup.py (path:/tmp/pip-cFHHeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:00 INFO - Running setup.py (path:/tmp/pip-LlMZN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:00 INFO - Running setup.py (path:/tmp/pip-pgUGbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:00 INFO - Running setup.py (path:/tmp/pip-ljHljC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:00 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)) 04:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:00 INFO - Running setup.py (path:/tmp/pip-y4_xFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:01 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)) 04:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:01 INFO - Running setup.py (path:/tmp/pip-uP2zM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:01 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)) 04:54:01 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)) 04:54:01 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)) 04:54:01 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)) 04:54:01 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)) 04:54:01 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)) 04:54:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:01 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 04:54:01 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 04:54:01 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 04:54:01 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 04:54:01 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 04:54:01 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 04:54:02 INFO - Downloading blessings-1.5.1.tar.gz 04:54:02 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 04:54:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:02 INFO - Installing collected packages: blessings 04:54:02 INFO - Running setup.py install for blessings 04:54:03 INFO - Successfully installed blessings 04:54:03 INFO - Cleaning up... 04:54:03 INFO - Return code: 0 04:54:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:54:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:54:03 INFO - Reading from file tmpfile_stdout 04:54:03 INFO - Current package versions: 04:54:03 INFO - argparse == 1.2.1 04:54:03 INFO - blessings == 1.5.1 04:54:03 INFO - blobuploader == 1.2.4 04:54:03 INFO - docopt == 0.6.1 04:54:03 INFO - manifestparser == 1.1 04:54:03 INFO - mozInstall == 1.12 04:54:03 INFO - mozcrash == 0.16 04:54:03 INFO - mozdebug == 0.1 04:54:03 INFO - mozdevice == 0.47 04:54:03 INFO - mozfile == 1.2 04:54:03 INFO - mozhttpd == 0.7 04:54:03 INFO - mozinfo == 0.9 04:54:03 INFO - mozleak == 0.1 04:54:03 INFO - mozlog == 3.1 04:54:03 INFO - moznetwork == 0.27 04:54:03 INFO - mozprocess == 0.22 04:54:03 INFO - mozprofile == 0.28 04:54:03 INFO - mozrunner == 6.11 04:54:03 INFO - mozscreenshot == 0.1 04:54:03 INFO - mozsystemmonitor == 0.0 04:54:03 INFO - moztest == 0.7 04:54:03 INFO - mozversion == 1.4 04:54:03 INFO - psutil == 3.1.1 04:54:03 INFO - requests == 1.2.3 04:54:03 INFO - wsgiref == 0.1.2 04:54:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:03 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:54:03 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 04:54:03 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 04:54:03 INFO - Using env: {'DISPLAY': ':0', 04:54:03 INFO - 'HOME': '/home/cltbld', 04:54:03 INFO - 'LANG': 'en_US.UTF-8', 04:54:03 INFO - 'LANGUAGE': 'en_US:en', 04:54:03 INFO - 'LOGNAME': 'cltbld', 04:54:03 INFO - 'MAIL': '/var/mail/cltbld', 04:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:03 INFO - 'MOZ_NO_REMOTE': '1', 04:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:03 INFO - 'NO_EM_RESTART': '1', 04:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:03 INFO - 'SHELL': '/bin/bash', 04:54:03 INFO - 'SHLVL': '1', 04:54:03 INFO - 'TERM': 'linux', 04:54:03 INFO - 'TMOUT': '86400', 04:54:03 INFO - 'USER': 'cltbld', 04:54:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:03 INFO - '_': '/tools/buildbot/bin/python'} 04:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 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)) 04:54:03 INFO - Cleaning up... 04:54:03 INFO - Return code: 0 04:54:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:03 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:54:03 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 04:54:03 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 04:54:03 INFO - Using env: {'DISPLAY': ':0', 04:54:03 INFO - 'HOME': '/home/cltbld', 04:54:03 INFO - 'LANG': 'en_US.UTF-8', 04:54:03 INFO - 'LANGUAGE': 'en_US:en', 04:54:03 INFO - 'LOGNAME': 'cltbld', 04:54:03 INFO - 'MAIL': '/var/mail/cltbld', 04:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:03 INFO - 'MOZ_NO_REMOTE': '1', 04:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:03 INFO - 'NO_EM_RESTART': '1', 04:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:03 INFO - 'SHELL': '/bin/bash', 04:54:03 INFO - 'SHLVL': '1', 04:54:03 INFO - 'TERM': 'linux', 04:54:03 INFO - 'TMOUT': '86400', 04:54:03 INFO - 'USER': 'cltbld', 04:54:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:03 INFO - '_': '/tools/buildbot/bin/python'} 04:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:03 INFO - Downloading/unpacking jsonschema 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 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 04:54:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:05 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 04:54:05 INFO - Downloading/unpacking functools32 (from jsonschema) 04:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:05 INFO - warning: no files found matching '*.txt' 04:54:05 INFO - no previously-included directories found matching 'build' 04:54:05 INFO - no previously-included directories found matching 'dist' 04:54:05 INFO - no previously-included directories found matching '.git*' 04:54:05 INFO - Installing collected packages: jsonschema, functools32 04:54:05 INFO - Running setup.py install for functools32 04:54:05 INFO - warning: no files found matching '*.txt' 04:54:05 INFO - no previously-included directories found matching 'build' 04:54:05 INFO - no previously-included directories found matching 'dist' 04:54:05 INFO - no previously-included directories found matching '.git*' 04:54:05 INFO - Successfully installed jsonschema functools32 04:54:05 INFO - Cleaning up... 04:54:05 INFO - Return code: 0 04:54:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:05 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 0x7f08ddb77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe81480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', '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 04:54:05 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 04:54:05 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 04:54:05 INFO - Using env: {'DISPLAY': ':0', 04:54:05 INFO - 'HOME': '/home/cltbld', 04:54:05 INFO - 'LANG': 'en_US.UTF-8', 04:54:05 INFO - 'LANGUAGE': 'en_US:en', 04:54:05 INFO - 'LOGNAME': 'cltbld', 04:54:05 INFO - 'MAIL': '/var/mail/cltbld', 04:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:05 INFO - 'MOZ_NO_REMOTE': '1', 04:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:05 INFO - 'NO_EM_RESTART': '1', 04:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:05 INFO - 'SHELL': '/bin/bash', 04:54:05 INFO - 'SHLVL': '1', 04:54:05 INFO - 'TERM': 'linux', 04:54:05 INFO - 'TMOUT': '86400', 04:54:05 INFO - 'USER': 'cltbld', 04:54:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:05 INFO - '_': '/tools/buildbot/bin/python'} 04:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:06 INFO - Downloading/unpacking flake8 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:54:07 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 04:54:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:54:07 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 04:54:07 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 04:54:07 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 04:54:07 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 04:54:07 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 04:54:07 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 04:54:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:54:08 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 04:54:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:08 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 04:54:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:54:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:08 INFO - no previously-included directories found matching 'docs/_build' 04:54:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:54:08 INFO - Running setup.py install for pep8 04:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:08 INFO - no previously-included directories found matching 'docs/_build' 04:54:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:54:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:54:08 INFO - Cleaning up... 04:54:08 INFO - Return code: 0 04:54:08 INFO - Running post-action listener: _resource_record_post_action 04:54:08 INFO - Running post-action listener: _start_resource_monitoring 04:54:08 INFO - Starting resource monitoring. 04:54:08 INFO - ##### 04:54:08 INFO - ##### Running install step. 04:54:08 INFO - ##### 04:54:08 INFO - Running pre-action listener: _resource_record_pre_action 04:54:08 INFO - Running main action method: install 04:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:54:08 INFO - Reading from file tmpfile_stdout 04:54:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:54:09 INFO - Reading from file tmpfile_stdout 04:54:09 INFO - Output received: 04:54:09 INFO - Usage: mozinstall [options] installer 04:54:09 INFO - Options: 04:54:09 INFO - -h, --help show this help message and exit 04:54:09 INFO - -d DEST, --destination=DEST 04:54:09 INFO - Directory to install application into. [default: 04:54:09 INFO - "/builds/slave/test-pgo"] 04:54:09 INFO - --app=APP Application being installed. [default: firefox] 04:54:09 INFO - mkdir: /builds/slave/test-pgo/build/application 04:54:09 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'] 04:54:09 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 04:54:25 INFO - Reading from file tmpfile_stdout 04:54:25 INFO - Output received: 04:54:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:54:25 INFO - Running post-action listener: _resource_record_post_action 04:54:25 INFO - ##### 04:54:25 INFO - ##### Running run-tests step. 04:54:25 INFO - ##### 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: run_tests 04:54:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:54:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:54:25 INFO - Python 2.7.3 04:54:25 INFO - Return code: 0 04:54:25 INFO - grabbing minidump binary from tooltool 04:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:25 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 0xf10660>, '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 0xf11560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:54:25 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 04:54:25 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 04:54:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:25 INFO - Return code: 0 04:54:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:54:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:54:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:54:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:54:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:54:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:54:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:54:26 INFO - Return code: 0 04:54:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 04:54:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:54:26 INFO - Using env: {'DISPLAY': ':0', 04:54:26 INFO - 'HOME': '/home/cltbld', 04:54:26 INFO - 'LANG': 'en_US.UTF-8', 04:54:26 INFO - 'LANGUAGE': 'en_US:en', 04:54:26 INFO - 'LOGNAME': 'cltbld', 04:54:26 INFO - 'MAIL': '/var/mail/cltbld', 04:54:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:54:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:26 INFO - 'MOZ_NO_REMOTE': '1', 04:54:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:26 INFO - 'NO_EM_RESTART': '1', 04:54:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:54:26 INFO - 'SHELL': '/bin/bash', 04:54:26 INFO - 'SHLVL': '1', 04:54:26 INFO - 'TERM': 'linux', 04:54:26 INFO - 'TMOUT': '86400', 04:54:26 INFO - 'USER': 'cltbld', 04:54:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561', 04:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:26 INFO - '_': '/tools/buildbot/bin/python'} 04:54:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:54:26 INFO - mozversion application_buildid: 20160111023002 04:54:26 INFO - mozversion application_changeset: 98d1a38f79a104f137008d29de2f05338b1fc349 04:54:26 INFO - mozversion application_display_name: Nightly 04:54:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:26 INFO - mozversion application_name: Firefox 04:54:26 INFO - mozversion application_remotingname: firefox 04:54:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:54:26 INFO - mozversion application_vendor: Mozilla 04:54:26 INFO - mozversion application_version: 46.0a1 04:54:26 INFO - mozversion platform_buildid: 20160111023002 04:54:26 INFO - mozversion platform_changeset: 98d1a38f79a104f137008d29de2f05338b1fc349 04:54:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:54:26 INFO - mozversion platform_version: 46.0a1 04:54:26 INFO - using testdate: 1452516866 04:54:26 INFO - actual date: 1452516866 04:54:26 INFO - starting webserver on 'localhost:56474' 04:54:26 INFO - SUITE-START | Running 3 tests 04:54:26 INFO - TEST-START | dromaeo_css 04:54:26 INFO - operating with platform_type : linux_ 04:54:26 INFO - Initialising browser for dromaeo_css test... 04:54:26 INFO - TEST-INFO | started process 5868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJe3x1T/profile http://localhost:56474/getInfo.html) 04:54:29 INFO - PROCESS | 5868 | 04:54:29 INFO - PROCESS | 5868 | (process:5950): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:54:30 INFO - PROCESS | 5868 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:54:31 INFO - PROCESS | 5868 | __metrics Screen width/height:1600/1200 04:54:31 INFO - PROCESS | 5868 | colorDepth:24 04:54:31 INFO - PROCESS | 5868 | Browser inner width/height: 1024/697 04:54:31 INFO - PROCESS | 5868 | __metrics 04:54:31 INFO - PROCESS | 5868 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:54:32 INFO - TEST-INFO | 5868: exit 0 04:54:32 INFO - Browser initialized. 04:54:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:32 INFO - TEST-INFO | started process 5999 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJe3x1T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:33 INFO - PROCESS | 5999 | 04:54:33 INFO - PROCESS | 5999 | (process:6058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:54:43 INFO - PROCESS | 5999 | RSS: Main: 150294528 04:54:43 INFO - PROCESS | 5999 | 04:55:33 INFO - PROCESS | 5999 | 1452516933509 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] 04:57:42 INFO - PROCESS | 5999 | Cycle 1(1): loaded http://localhost:56474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56474/tests/dromaeo/cssquery-ext.html) 04:57:43 INFO - PROCESS | 5999 | RSS: Main: 158347264 04:57:43 INFO - PROCESS | 5999 | 05:00:45 INFO - PROCESS | 5999 | Cycle 1(1): loaded http://localhost:56474/tests/dromaeo/cssquery-ext.html (next: http://localhost:56474/tests/dromaeo/cssquery-jquery.html) 05:00:46 INFO - PROCESS | 5999 | RSS: Main: 154562560 05:00:46 INFO - PROCESS | 5999 | 05:03:48 INFO - PROCESS | 5999 | Cycle 1(1): loaded http://localhost:56474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56474/tests/dromaeo/cssquery-mootools.html) 05:03:48 INFO - PROCESS | 5999 | RSS: Main: 153198592 05:03:48 INFO - PROCESS | 5999 | 05:06:50 INFO - PROCESS | 5999 | Cycle 1(1): loaded http://localhost:56474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56474/tests/dromaeo/cssquery-prototype.html) 05:06:50 INFO - PROCESS | 5999 | RSS: Main: 152444928 05:06:50 INFO - PROCESS | 5999 | 05:09:53 INFO - PROCESS | 5999 | Cycle 1(1): loaded http://localhost:56474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56474/tests/dromaeo/cssquery-yui.html) 05:09:53 INFO - PROCESS | 5999 | RSS: Main: 153059328 05:09:53 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | Cycle 1(1): loaded http://localhost:56474/tests/dromaeo/cssquery-yui.html (next: http://localhost:56474/tests/dromaeo/cssquery-dojo.html) 05:12:56 INFO - PROCESS | 5999 | RSS: Main: 154779648 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | __start_tp_report 05:12:56 INFO - PROCESS | 5999 | _x_x_mozilla_page_load 05:12:56 INFO - PROCESS | 5999 | _x_x_mozilla_page_load_details 05:12:56 INFO - PROCESS | 5999 | |i|pagename|runs| 05:12:56 INFO - PROCESS | 5999 | |0;dojo.html;3191.297914458819;3210.9518357224633;3225.5000474926396;3250.171206342383;3262.8531716072775;5225.921611175831;5230.058589453897;5237.3715154181455;5241.973790131049;5242.21366794981;5213.608979326546;5244.082285600014;5256.159014557672;5272.446393128724;5287.68273903566;4515.841945531907;4779.139754844118;4961.553460188582;4967.453580106186;4969.577585905203;4726.881827954311;4884.340614017097;4936.555709986101;4943.6539442239055;4947.084789313988;4750.049990001996;4786.353842231307;4884.609231261491;4885.780139893678;4902.730349830758;4756.881077973044;4801.2798080287885;4819.397575303087;4842.055799119174;4845.6123510119105;4705.3647757552635;4784.234522476422;4797.568218860284;4814.325994360793;4837.419509658828;5082.79668813247;5127.9230811537855;5136.717480538568;5151.536361727425;5173.405058418292;5592.552595792326;5604.943950560483;5620.85947851307;5638.943610563882;5676.517496012844;5677.971610141964;5697.487226149667;5719.456651618089;5743.971280143614;5768.3654797972185;5362.383325917531;5364.249005139322;5378.413368056433;5384.865378365533;5393.946060539344;5802.187693722883;5857.619254748428;5858.53131749459;5860.09168578871;5887.411258874078;5470.452954704578;5538.556915446755;5548.334199896039;5631.436856314418;5676.0066988276885;5632.633878797947;5634.211210430543;5635.830925072254;5635.887282254332;5639.605227634108;5554.250176226158;5574.804881829116;5579.246801681802;5598.1322894951345;5615.9157612635845;5449.155380915964;5609.971950140305;5646.97176514123;5657.632253903483;5676.403977582295;4381.211381951216;4390.473143222834;4392.05570802279;4398.252297109435;4426.026274219666;3900.6294402031763;3927.116398810302;3935.74417662851;3950.1704642025497;3986.8405263789705;5292.92060619091;5359.330083739533;5367.2485851980755;5377.569794416438;5386.272853164851;5669.801556945487;5677.943220567824;5726.169705392695;5736.483716465538;5746.569007324468;5289.312389389354;5341.038613049611;5350.143976963667;5352.304200453916;5411.377691565521;4765.785539650724;4769.976150119297;4776.450708168605;4776.474587795409;4792.353032340589;5933.288005439289;5934.198883150806;5948.702564871739;5950.761969521257;5962.5826192167;5676.233708449472;5745.540356771365;5753.62601430914;5771.365149833431;5776.335721392094;5715.742791574472;5792.420757924174;5820.923129221108;5849.883002340014;5880.676562789087;5631.549476041989;5658.953093677683;5666.716664166693;5670.036093864135;5681.659100453986;5716.885662286814;5747.281589801275;5751.511121554715;5756.3380211276235;5757.078867381367;5481.123020316731;5595.244641973444;5595.552355811444;5597.748101335368;5607.915881261702;5628.0432326505415;5633.38032816398;5639.295088113986;5643.209950607001;5679.00617391963;5473.562115030708;5508.118701007819;5516.696581688046;5528.778848846001;5531.529819965348;5403.486668766461;5483.670979741229;5520.91718624229;5554.500094991308;5619.999006013682;5524.558035357242;5533.197686335539;5533.335999680065;5534.584906132137;5536.501714845684 05:12:56 INFO - PROCESS | 5999 | |1;ext.html;508.7761384990604;520.323579346849;530.6206062665195;546.3007350591245;560.3527925246342;35263.47104793427;35706.642933570656;35810.92567222981;35886.8205658972;35931.640683593156;38603.61396386042;38647;38933.610663893356;39090;39120;8521.190486903733;8660.177283158122;8670.913290867074;8680.609372578218;8716.694915677952;8367.748967530984;8543.95728021359;8573.699920502784;8705.608247628841;8747.125287471266;8676.089010653885;8756.299496040301;8798.340124490656;8817.074207208247;8834.514101724402;8651.134886511361;8740.912590874104;8753.431026983257;8779.341549383822;8786.428882122706;8530.616122274512;8610.311175106039;8640.827183456297;8658.393912426132;8660.393772435931;38444.42333365002;38488.615113848784;38507.42238866419;38748.22503549942;38808;3268.6077670679433;3280.114369120348;3301.339732053575;3316.9004929852144;3331.4336562784383;28733;29308.12075637713;29365.853170734008;29500.852495737385;30058.84970575133;3782.8108594570162;4028.637422631977;4077.4699289092523;4113.280175969194;4153.501579810412;266196;268771;269548;270164;270418.64790676115;40760.59239407568;41165.588344116775;54642.180367294524;55071;55096.44903550993;38962;39291.41062884059;39467;39533.209335813124;39556.2088758229;14093;14122.505712300226;14123.646908827155;14209.147451152758;14238.430462781373;11396.430178491042;11444.542218311175;11503.137264705181;11546.307221566733;11602.419879006016;13549.458021679022;13587;13947.721045579032;13957.58127256184;13988.860111398959;5652.576056795675;5705.857353566111;5706.487780738108;5810.21562089121;5828.562857785683;947.4078700811992;1003.4180175498193;1035.8601588785418;1046.283295942282;1048.3185929145964;27740;28373.43253134926;28592.714072859006;28660.570091448644;28831.71168288332;1025.5385076715509;1082.3938594387168;1103.9282446640943;1118.2731224704007;1119.7144728094283;15828.44600438979;16366.672666546603;16647.83352166487;16757.748633770505;16969.915150424167;373907;375735;377771;378972;381006;51925;52089.739551302;52256;52362.73818630959;52567.474325256255;1262.6338361875137;1262.9368531573384;1323.9602811915659;1333.0601925642204;1333.6332508560224;28434.28914277077;29153.271168220963;29440.41119177647;29627;29743.25641858971;43524.34713479237;43549;43889.34165987577;43955.560444396426;44057.339139913565;290152;291074;295278;295367.75477348955;295852;31042;42019.1596168081;42471.78764106159;42545.78727106345;42647.786761065996;38063.61936380711;38763.80618096892;38881.2223755529;39047.219055619295;39106.2178756429;32957.67042329642;32986.67013329836;33152.83423582867;33221.33557328791;33776;32878.506822398165;37348;37709.20266859811;38339.80830095831;41887.790561047;34809.65190348064;34950.82524587361;35090.473642895886;35259.47110793289;35287.117822053624;30779.384412312076;32069.35861282808;32156.51765223477;32904.34191316208;32954.5056824143;24573.877130614233;25606.8719656408;26383.208503744918;27024.32439189036;27038.864805676632 05:12:56 INFO - PROCESS | 5999 | |2;jquery.html;362.24471975930186;362.5721648454824;363.7871844970692;364.22965428119534;369.0165708387148;16399.098049607266;16643.50069497914;16947.49157525273;17077.658446831058;17704.557386065353;15160.848391516081;15309;15586.688266234669;15593.610159745984;15669.45156919508;4596.287575425815;4755.809767609291;4788.5450882166315;4798.352222449959;4800.399950006249;4607.58531732144;4755.90488190236;4995.300657907896;4999.075171093359;5005.824796132136;4969.925451118218;4993.525615066563;5013.824516141935;5196.168613021917;5200.115980283361;5172.327597412331;5202.531772140525;5237.45006774289;5499.50504454601;6089.117078023662;5369.865753356158;5399.811006614789;5405.405405405402;5407.270018547485;5413.972930135364;14581.19803410812;18870.811291887043;19357.903210483997;19511;19619.117139728747;1961.852861035428;2054.5377290109755;2148.9247876324253;2186.3768825884545;2216.7229096362953;9320;9349.672761453385;9467;10298.7425314367;13028.739425211537;1796.8293012163824;1805.2417984446563;1836.494963884929;1851.333519932823;1919.7216403621537;54912;55216.44783552153;55573;56460.43539564634;57057;9573.18627916621;9811.411315321104;10040.899591004143;10074.143697785623;10128.848067278997;13015.934920325337;13052.934735326262;13131;13131.474741010443;13139.34303284832;7527.661255243527;7544.132424771222;7560.697572097164;7591.962040189764;7593.696252149963;7208.24313447091;7281.635918204069;7299.781006569811;7312.817179570553;7375.44684148691;4340.479142502857;4367.017421080295;4374.234508960919;4385.758783266951;4413.095315460323;1770.9645807083787;1803.4048763907879;1851.990740046318;2953.837538935379;2959.926001849971;847.2501835875295;856.8157846063126;918.3342076994126;920.4845286639503;1048.9947550262352;15808.288627011812;16243;16283.755743663854;16650.916745416194;16716.832831671527;873.8121303919561;902.4072512016296;914.4147745442922;930.134974473746;936.4334577580602;9424.95287523558;9449;9555.522223888778;9580.425174489414;9779;393784;409816;409886;413176;413707;68440.31559684439;70469.6476517614;70689.64655176795;71083;71184.64407677928;1079.5034284229343;1080.7352198711367;1148.3167515328366;1159.3797318434597;1164.6214980131492;14427.42290308376;14532.128072315694;14595.635109121931;14638.414463421344;14854.405823766929;31732.841335794095;31919.202019949687;32780.67219327872;32937.17657058497;33007.174820629676;41311.793441032605;41340.37989430101;42398.36402453904;43374.78312608417;43417.131657366044;6504.544681872224;6986.0219569259325;7159.57042577447;7276.381507571704;7486.101667799899;3819.3125237457525;7824.78715799052;8465.57672116404;10085.243606729671;10282.331648442827;9170.03714609983;9701.320907536405;9728.17310528613;9821.263405244492;9860.802783944138;8515.446495977742;8544.40189186751;9519.00050494688;9709.609819379248;9780.070893265129;8940.329475289509;9421.434713917188;9809.901900980898;9903;10186.490675466346;7169.247229040876;7254.528455650366;7282.2353652867805;7387.298206670358;7389.778306650809;8182.386321025828;8539.530325832138;9372.297077719062;9806.362586432144;9921.603135874773 05:12:56 INFO - PROCESS | 5999 | |3;mootools.html;1435.9712805743886;1452.869241768241;1575.2438829361906;1704.3779020657464;1729.1613567419806;7108.537945033576;7231.7830465086;7300.853982920345;7318.085239345089;7373.336399724024;7334.816629584263;7362.153352364479;7398.408127349812;7425.405967522599;7477.513961592493;2283.2693538067824;2303.7120359955006;2306.6885970394032;2320.6867072945106;2321.4080409495555;2340.531893621274;2364.160722943356;2367.396313939943;2369.727481339642;2374.857508549484;2295.701558797354;2336.4742932840145;2354.058376649337;2358.5377066218966;2360.504294098233;2326.639370897505;2346.8474549154334;2347.5187586544716;2349.236498138112;2356.528694261146;2374.4063984004;2384.0106355862295;2390.4262976885598;2392.294273189413;2402.8318017738766;7230.819229519251;7239.457040721967;7249.746258880914;7252.347288743986;7253.782386528413;4548.454185497729;4720.905581888377;4724.055188962221;4730.526947305277;4730.787114579852;2918.8248705077763;3111.1133327001694;3119.407312610597;3131.812091274508;3137.7646676499126;972.7276362618478;979.2704435195825;996.227923359395;1001.3691374434133;1033.5659023210194;9869.309148359618;9875.753106172331;9929.106380425725;9931.602735890556;9932.205423566169;4059.7767122808527;4113.691473139466;4113.85601503946;4118.114605359862;4310.051788606502;8158;8209.179082091863;8226;8226.383021273428;8233.547154906537;4730.290456431563;4742.762861856893;4749.667523273338;4764.785584648699;4771.785269662873;4343.131373725204;4355.673324500675;4379.671524635665;4388.122375524844;4398.076403955141;3350.8157051361923;3364.4280472319765;3388.881389151368;3403.761736678409;3419.8461069251944;992.4442312305132;997.3816233935007;998.3909815012836;1009.0464511037;1040.3341861208833;932.9067093290753;942.1803031362622;1097.9231453798318;1145.2212495502972;1307.2483322089836;6921.204061532888;6922.688479018356;6944.270851560615;6967.198772141269;7001.299870012958;625.9874802503924;627.5795217204484;639.491604174673;640.5708175522411;771.4831063187678;5388.622796404293;5412.242286079873;5437.13005919051;5450.427705090988;5472.835814925558;8773;8790.164934331227;8959;9004.054574269607;9040;8828.073052329413;8833.734987950373;8866.73399798007;8872.979607345109;8936.821263574691;6745.494087943423;6884.793456196322;6903.275156108737;7027.472939529555;7054.259302773237;6883.965580172067;6917.757878474229;6919.135108111486;6951.02685624003;6961.234264231032;7854.764357069297;8158.796030099295;8214.958925205336;8221.876671850046;8262.091169971178;8204.220599043081;8366.83266334682;8395.412321137706;8436.831263374821;8481.10948350439;6620.337966203341;6664.533482656361;6769.458443324621;6779.508508128204;6790.117284752951;7032.507724459443;7065.364117229474;7087.114110736158;7089.716411343695;7108;5871.266091738533;6620.536562440583;6746.359095885883;6880.931190688229;6935.514513984174;6518.57629254097;6535.542512024303;6618.569792963442;6643.2360278568585;6654.101696271135;6506.837329066811;6577.309382514767;6620.470362370903;6629.105070815378;6631.734730610721;6207.937920620917;6284.214473190851;6295.5907865988565;6305;6307.558470906993;6153.938460615515;6326.746930122744;6346.397092276226;6359.523035772243;6369.108324834619 05:12:56 INFO - PROCESS | 5999 | |4;prototype.html;334.4164433064303;343.6735101653429;354.10588264631804;357.545916685809;358.99282014359727;6207.286162091361;6255.874882502348;6261.499080073595;6295.716692748826;6396.200474940632;6185.0722391641275;6223.564350495456;6226.595271307362;6228.096925945735;6291.811245662626;4766.571008609225;4768.094062128202;4768.451628062765;4772.212584923492;4775.021120670272;4766.332713420124;4768.761561921908;4777.498362671921;4781.641376896747;4782.163121453732;4520.547945205486;4652.604528615072;4657.324687920266;4668.789904454307;4735.644826637998;4637.930431043537;4642.744649044318;4644.744539050351;4648.86053418398;4652.348671186037;3950.604939506055;3978.8806335809973;3994.9201015979515;4003.559608443069;4017.27689015977;5916.467517923407;5923.466887980059;5926.614770039977;5930.9406905931255;5931.733072011727;5326.440723723992;5389.272448219519;5479.013777520045;5485.725713714338;5491.313585801775;6561.704723287464;6569.37590928861;6570.441512471446;6571.507136964747;6583.506237032194;4534.093181363741;4534.5692159245145;4537.659675524316;4545.954540454586;4553.772311384418;6675.499337549703;6847.2125705544;6919.446444284496;6922.619255940921;6930.61881596512;4599.563041511051;4636.884077898079;4649.767511624405;4658.557437043475;4673.836415725501;4701.059788042337;4715.4577223619035;4724.929126063112;4727.456342520585;4734.431868175772;5468.562514998791;5472.863178420492;5474.534664553557;5475.178723191473;5480.369757477862;6426.4216220540375;6596.406323430819;6620.073189753439;6641.369069938348;6652.866942661217;1639.5737108351914;1685.7302831547138;1735.982640173582;1737.3050779688226;1741.1903464888887;1148.1618418554501;1174.6593487888417;1188.1385995153444;1188.9227200231958;1193.0813273779142;6161.507079433634;6179.28938172107;6205.5345849061505;6215.223097112861;6237.532185086136;6624.304448032984;6667;6674.833129171712;6719.596824190564;6736.865262694719;6065.75736970525;6143.723532441051;6160.168377269011;6195.132681424604;6197.659128747962;3632.7093832493338;3643.890683279506;3648;3657.122290650278;3663.19409729859;6958.79123626292;6988.231294557595;7010.649467526705;7013.473989450812;7029.648517574101;6723.125993620798;6846.178458584902;6868.450523958071;6880.724771009203;6885.277045910208;6998.195207551095;7003.194632617212;7008.229094799568;7008.369246767816;7010.983407405897;6703.798886033427;6704.899426508508;6705.932940670531;6714.362135597111;6720.731170753115;6524.217093948757;6648.7340506379205;6649.368310010541;6652;6655.700493477708;6964.408025317702;7001.704684633359;7004.579725216503;7010.193827709879;7012.1935977363255;4778.187708089703;4786.329913812138;4792;4812.302216178565;4816.494268101939;6635.369639884203;6690.732370705117;6735.158105236846;6737.898931515933;6826.112605361272;6671.366220209073;6688.097106890507;6696.7656132035145;6698.39714425704;6717.16035495563;6630.071789949508;6649.63427011519;6654.234763002317;6664.766733164316;6670.83322916931;6444.677766111769;6527.477801775752;6541.6075035498025;6548.345165483413;6566.146400967844;6684.0642310075655;6699.899501507579;6715;6716.361945615159;6738.124043874461;6510.381513756186;6529.771457998947;6542.8364290893105;6545.247296560957;6551.21385433751 05:12:56 INFO - PROCESS | 5999 | |5;yui.html;732.8607564562733;743.8437928035113;788.3653658804661;815.9755207343782;851.0893344121793;12940.805887911678;12980.221186728802;12997.870021299785;13075.476980920763;13094.672633184175;12516.249025058503;12556.18384804987;12607.558735444261;12610.243385396883;12614.936925315384;655.8852200864853;658.1049772309655;765.865973454646;779.154617240295;787.4173111897212;777.8872063550782;783.0564170174925;784.7684932944767;786.6931896560346;787.6455594982281;827.4001349021971;829.3613917283687;830.9459885107478;832.4755404095412;834.4117397234935;822.8230930349973;824.1593574553922;827.1686954610608;828.0312034919159;828.5939889454185;608.2974164839617;611.10778263735;612.7640858269598;612.8437248501648;616.5098746496546;13120.60638180856;13139.60581182566;13161.341932903317;13179.670508237275;13187.736245275137;12772.425240864184;12973.610791676265;13160.6709832254;13337.799933001013;13371;10103.747406314827;10182.28723989321;10202.693919182362;10386.636467723594;10681.198910081697;3565.893023209308;3618.8914332570066;3630.110622897381;3650.0327413235514;3687.575928768199;41381.172376552604;41688.374674379906;41728.37407438891;41759.1648167038;41761.58238417607;9192.770180745534;9433;9445.102715242041;9546.95226523863;9762.316637835283;17415.303387864344;17507.73738393925;17552.94682319065;17624.118794060247;17764.200610972537;7346.889796653055;7430.182679905206;7550.962245188739;7605.771826845204;7610.733624323122;4390.165868484977;4392.31919052541;4407.933880991788;4457.108578284357;4467.285234362486;2984.865681044358;2992.1771512834143;2994.520876659724;2997.3405850712807;3003.384306217264;556.5130510803048;556.9331680198402;561.4497792163702;571.8456016875421;575.3211210771246;569.4789267819981;644.365300179323;680.6324584724292;693.8196069022091;693.8889777635655;8080.27277545012;8115.634796434175;8285.50286982783;8475.152484751476;9520.8571871422;548.8106603221883;590.4302348233974;599.8530360061812;611.996940015306;691.6368906324119;4159.604837540429;4225.936610950838;4338;4520.163769702615;4569.885752856205;51794.22308665373;52219.73890130525;52709.7364513175;58264;60299;48039;48740.75629621829;48810.75594622075;49035.50964490381;50071;45117.54882451199;45740;45881;46416.303755443696;46597.30104048442;8779.34154938395;8946.57434329518;9050;9200.125988031126;9228.630854766003;31846.522302165024;32580;33363.1659208512;34176.316473670886;34197.145071373416;40100;40412.79793601013;41598.37602436027;42520.362194566485;43016.784916076474;11194.216404851582;11374.886251137383;11423.885761142283;11565;11698.532058717896;12176.452059657513;12200.206986545845;12212.75574488523;12390.62828115158;12854.293013884326;11080.390578517936;11430;11439;11762.059035277329;11944.283342999448;10184.287099902936;10290.331128476626;10385.844212336971;10445.895541044492;10858.34849909008;11057.723556911142;11093.667189984313;11422.771544569228;11443.942780286045;11499.482523286304;9050.547472626211;9073.410228335137;9107.590158442754;9126.954365228132;9364;9795.363301385387;9901.900980990098;9923.950380248052;9968.50157492108;10076.395416275047 05:12:56 INFO - PROCESS | 5999 | __end_tp_report 05:12:56 INFO - PROCESS | 5999 | __start_cc_report 05:12:56 INFO - PROCESS | 5999 | _x_x_mozilla_cycle_collect,318 05:12:56 INFO - PROCESS | 5999 | __end_cc_report 05:12:56 INFO - PROCESS | 5999 | __startTimestamp1452517976874__endTimestamp 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | ------- Summary: start ------- 05:12:56 INFO - PROCESS | 5999 | Number of tests: 6 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | [#0] dojo.html Cycles:165 Average:5279.48 Median:5516.70 stddev:581.84 (10.5%) stddev-sans-first:560.09 05:12:56 INFO - PROCESS | 5999 | Values: 3191.3 3211.0 3225.5 3250.2 3262.9 5225.9 5230.1 5237.4 5242.0 5242.2 5213.6 5244.1 5256.2 5272.4 5287.7 4515.8 4779.1 4961.6 4967.5 4969.6 4726.9 4884.3 4936.6 4943.7 4947.1 4750.0 4786.4 4884.6 4885.8 4902.7 4756.9 4801.3 4819.4 4842.1 4845.6 4705.4 4784.2 4797.6 4814.3 4837.4 5082.8 5127.9 5136.7 5151.5 5173.4 5592.6 5604.9 5620.9 5638.9 5676.5 5678.0 5697.5 5719.5 5744.0 5768.4 5362.4 5364.2 5378.4 5384.9 5393.9 5802.2 5857.6 5858.5 5860.1 5887.4 5470.5 5538.6 5548.3 5631.4 5676.0 5632.6 5634.2 5635.8 5635.9 5639.6 5554.3 5574.8 5579.2 5598.1 5615.9 5449.2 5610.0 5647.0 5657.6 5676.4 4381.2 4390.5 4392.1 4398.3 4426.0 3900.6 3927.1 3935.7 3950.2 3986.8 5292.9 5359.3 5367.2 5377.6 5386.3 5669.8 5677.9 5726.2 5736.5 5746.6 5289.3 5341.0 5350.1 5352.3 5411.4 4765.8 4770.0 4776.5 4776.5 4792.4 5933.3 5934.2 5948.7 5950.8 5962.6 5676.2 5745.5 5753.6 5771.4 5776.3 5715.7 5792.4 5820.9 5849.9 5880.7 5631.5 5659.0 5666.7 5670.0 5681.7 5716.9 5747.3 5751.5 5756.3 5757.1 5481.1 5595.2 5595.6 5597.7 5607.9 5628.0 5633.4 5639.3 5643.2 5679.0 5473.6 5508.1 5516.7 5528.8 5531.5 5403.5 5483.7 5520.9 5554.5 5620.0 5524.6 5533.2 5533.3 5534.6 5536.5 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | [#1] ext.html Cycles:180 Average:46794.77 Median:36639.82 stddev:83155.36 (227.0%) stddev-sans-first:83316.01 05:12:56 INFO - PROCESS | 5999 | Values: 508.8 520.3 530.6 546.3 560.4 35263.5 35706.6 35810.9 35886.8 35931.6 38603.6 38647.0 38933.6 39090.0 39120.0 8521.2 8660.2 8670.9 8680.6 8716.7 8367.7 8544.0 8573.7 8705.6 8747.1 8676.1 8756.3 8798.3 8817.1 8834.5 8651.1 8740.9 8753.4 8779.3 8786.4 8530.6 8610.3 8640.8 8658.4 8660.4 38444.4 38488.6 38507.4 38748.2 38808.0 3268.6 3280.1 3301.3 3316.9 3331.4 28733.0 29308.1 29365.9 29500.9 30058.8 3782.8 4028.6 4077.5 4113.3 4153.5 266196.0 268771.0 269548.0 270164.0 270418.6 40760.6 41165.6 54642.2 55071.0 55096.4 38962.0 39291.4 39467.0 39533.2 39556.2 14093.0 14122.5 14123.6 14209.1 14238.4 11396.4 11444.5 11503.1 11546.3 11602.4 13549.5 13587.0 13947.7 13957.6 13988.9 5652.6 5705.9 5706.5 5810.2 5828.6 947.4 1003.4 1035.9 1046.3 1048.3 27740.0 28373.4 28592.7 28660.6 28831.7 1025.5 1082.4 1103.9 1118.3 1119.7 15828.4 16366.7 16647.8 16757.7 16969.9 373907.0 375735.0 377771.0 378972.0 381006.0 51925.0 52089.7 52256.0 52362.7 52567.5 1262.6 1262.9 1324.0 1333.1 1333.6 28434.3 29153.3 29440.4 29627.0 29743.3 43524.3 43549.0 43889.3 43955.6 44057.3 290152.0 291074.0 295278.0 295367.8 295852.0 31042.0 42019.2 42471.8 42545.8 42647.8 38063.6 38763.8 38881.2 39047.2 39106.2 32957.7 32986.7 33152.8 33221.3 33776.0 32878.5 37348.0 37709.2 38339.8 41887.8 34809.7 34950.8 35090.5 35259.5 35287.1 30779.4 32069.4 32156.5 32904.3 32954.5 24573.9 25606.9 26383.2 27024.3 27038.9 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | [#2] jquery.html Cycles:180 Average:23562.16 Median:4799.38 stddev:66882.16 (1393.6%) stddev-sans-first:67047.09 05:12:56 INFO - PROCESS | 5999 | Values: 362.2 362.6 363.8 364.2 369.0 16399.1 16643.5 16947.5 17077.7 17704.6 15160.8 15309.0 15586.7 15593.6 15669.5 4596.3 4755.8 4788.5 4798.4 4800.4 4607.6 4755.9 4995.3 4999.1 5005.8 4969.9 4993.5 5013.8 5196.2 5200.1 5172.3 5202.5 5237.5 5499.5 6089.1 5369.9 5399.8 5405.4 5407.3 5414.0 14581.2 18870.8 19357.9 19511.0 19619.1 1961.9 2054.5 2148.9 2186.4 2216.7 9320.0 9349.7 9467.0 10298.7 13028.7 1796.8 1805.2 1836.5 1851.3 1919.7 54912.0 55216.4 55573.0 56460.4 57057.0 9573.2 9811.4 10040.9 10074.1 10128.8 13015.9 13052.9 13131.0 13131.5 13139.3 7527.7 7544.1 7560.7 7592.0 7593.7 7208.2 7281.6 7299.8 7312.8 7375.4 4340.5 4367.0 4374.2 4385.8 4413.1 1771.0 1803.4 1852.0 2953.8 2959.9 847.3 856.8 918.3 920.5 1049.0 15808.3 16243.0 16283.8 16650.9 16716.8 873.8 902.4 914.4 930.1 936.4 9425.0 9449.0 9555.5 9580.4 9779.0 393784.0 409816.0 409886.0 413176.0 413707.0 68440.3 70469.6 70689.6 71083.0 71184.6 1079.5 1080.7 1148.3 1159.4 1164.6 14427.4 14532.1 14595.6 14638.4 14854.4 31732.8 31919.2 32780.7 32937.2 33007.2 41311.8 41340.4 42398.4 43374.8 43417.1 6504.5 6986.0 7159.6 7276.4 7486.1 3819.3 7824.8 8465.6 10085.2 10282.3 9170.0 9701.3 9728.2 9821.3 9860.8 8515.4 8544.4 9519.0 9709.6 9780.1 8940.3 9421.4 9809.9 9903.0 10186.5 7169.2 7254.5 7282.2 7387.3 7389.8 8182.4 8539.5 9372.3 9806.4 9921.6 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | [#3] mootools.html Cycles:180 Average:5229.37 Median:6597.94 stddev:2645.38 (40.1%) stddev-sans-first:2637.43 05:12:56 INFO - PROCESS | 5999 | Values: 1436.0 1452.9 1575.2 1704.4 1729.2 7108.5 7231.8 7300.9 7318.1 7373.3 7334.8 7362.2 7398.4 7425.4 7477.5 2283.3 2303.7 2306.7 2320.7 2321.4 2340.5 2364.2 2367.4 2369.7 2374.9 2295.7 2336.5 2354.1 2358.5 2360.5 2326.6 2346.8 2347.5 2349.2 2356.5 2374.4 2384.0 2390.4 2392.3 2402.8 7230.8 7239.5 7249.7 7252.3 7253.8 4548.5 4720.9 4724.1 4730.5 4730.8 2918.8 3111.1 3119.4 3131.8 3137.8 972.7 979.3 996.2 1001.4 1033.6 9869.3 9875.8 9929.1 9931.6 9932.2 4059.8 4113.7 4113.9 4118.1 4310.1 8158.0 8209.2 8226.0 8226.4 8233.5 4730.3 4742.8 4749.7 4764.8 4771.8 4343.1 4355.7 4379.7 4388.1 4398.1 3350.8 3364.4 3388.9 3403.8 3419.8 992.4 997.4 998.4 1009.0 1040.3 932.9 942.2 1097.9 1145.2 1307.2 6921.2 6922.7 6944.3 6967.2 7001.3 626.0 627.6 639.5 640.6 771.5 5388.6 5412.2 5437.1 5450.4 5472.8 8773.0 8790.2 8959.0 9004.1 9040.0 8828.1 8833.7 8866.7 8873.0 8936.8 6745.5 6884.8 6903.3 7027.5 7054.3 6884.0 6917.8 6919.1 6951.0 6961.2 7854.8 8158.8 8215.0 8221.9 8262.1 8204.2 8366.8 8395.4 8436.8 8481.1 6620.3 6664.5 6769.5 6779.5 6790.1 7032.5 7065.4 7087.1 7089.7 7108.0 5871.3 6620.5 6746.4 6880.9 6935.5 6518.6 6535.5 6618.6 6643.2 6654.1 6506.8 6577.3 6620.5 6629.1 6631.7 6207.9 6284.2 6295.6 6305.0 6307.6 6153.9 6326.7 6346.4 6359.5 6369.1 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | [#4] prototype.html Cycles:180 Average:5495.69 Median:6219.39 stddev:1651.00 (26.5%) stddev-sans-first:1609.54 05:12:56 INFO - PROCESS | 5999 | Values: 334.4 343.7 354.1 357.5 359.0 6207.3 6255.9 6261.5 6295.7 6396.2 6185.1 6223.6 6226.6 6228.1 6291.8 4766.6 4768.1 4768.5 4772.2 4775.0 4766.3 4768.8 4777.5 4781.6 4782.2 4520.5 4652.6 4657.3 4668.8 4735.6 4637.9 4642.7 4644.7 4648.9 4652.3 3950.6 3978.9 3994.9 4003.6 4017.3 5916.5 5923.5 5926.6 5930.9 5931.7 5326.4 5389.3 5479.0 5485.7 5491.3 6561.7 6569.4 6570.4 6571.5 6583.5 4534.1 4534.6 4537.7 4546.0 4553.8 6675.5 6847.2 6919.4 6922.6 6930.6 4599.6 4636.9 4649.8 4658.6 4673.8 4701.1 4715.5 4724.9 4727.5 4734.4 5468.6 5472.9 5474.5 5475.2 5480.4 6426.4 6596.4 6620.1 6641.4 6652.9 1639.6 1685.7 1736.0 1737.3 1741.2 1148.2 1174.7 1188.1 1188.9 1193.1 6161.5 6179.3 6205.5 6215.2 6237.5 6624.3 6667.0 6674.8 6719.6 6736.9 6065.8 6143.7 6160.2 6195.1 6197.7 3632.7 3643.9 3648.0 3657.1 3663.2 6958.8 6988.2 7010.6 7013.5 7029.6 6723.1 6846.2 6868.5 6880.7 6885.3 6998.2 7003.2 7008.2 7008.4 7011.0 6703.8 6704.9 6705.9 6714.4 6720.7 6524.2 6648.7 6649.4 6652.0 6655.7 6964.4 7001.7 7004.6 7010.2 7012.2 4778.2 4786.3 4792.0 4812.3 4816.5 6635.4 6690.7 6735.2 6737.9 6826.1 6671.4 6688.1 6696.8 6698.4 6717.2 6630.1 6649.6 6654.2 6664.8 6670.8 6444.7 6527.5 6541.6 6548.3 6566.1 6684.1 6699.9 6715.0 6716.4 6738.1 6510.4 6529.8 6542.8 6545.2 6551.2 05:12:56 INFO - PROCESS | 5999 | 05:12:56 INFO - PROCESS | 5999 | [#5] yui.html Cycles:180 Average:13295.31 Median:4545.02 stddev:14990.63 (329.8%) stddev-sans-first:15003.00 05:12:56 INFO - PROCESS | 5999 | Values: 732.9 743.8 788.4 816.0 851.1 12940.8 12980.2 12997.9 13075.5 13094.7 12516.2 12556.2 12607.6 12610.2 12614.9 655.9 658.1 765.9 779.2 787.4 777.9 783.1 784.8 786.7 787.6 827.4 829.4 830.9 832.5 834.4 822.8 824.2 827.2 828.0 828.6 608.3 611.1 612.8 612.8 616.5 13120.6 13139.6 13161.3 13179.7 13187.7 12772.4 12973.6 13160.7 13337.8 13371.0 10103.7 10182.3 10202.7 10386.6 10681.2 3565.9 3618.9 3630.1 3650.0 3687.6 41381.2 41688.4 41728.4 41759.2 41761.6 9192.8 9433.0 9445.1 9547.0 9762.3 17415.3 17507.7 17552.9 17624.1 17764.2 7346.9 7430.2 7551.0 7605.8 7610.7 4390.2 4392.3 4407.9 4457.1 4467.3 2984.9 2992.2 2994.5 2997.3 3003.4 556.5 556.9 561.4 571.8 575.3 569.5 644.4 680.6 693.8 693.9 8080.3 8115.6 8285.5 8475.2 9520.9 548.8 590.4 599.9 612.0 691.6 4159.6 4225.9 4338.0 4520.2 4569.9 51794.2 52219.7 52709.7 58264.0 60299.0 48039.0 48740.8 48810.8 49035.5 50071.0 45117.5 45740.0 45881.0 46416.3 46597.3 8779.3 8946.6 9050.0 9200.1 9228.6 31846.5 32580.0 33363.2 34176.3 34197.1 40100.0 40412.8 41598.4 42520.4 43016.8 11194.2 11374.9 11423.9 11565.0 11698.5 12176.5 12200.2 12212.8 12390.6 12854.3 11080.4 11430.0 11439.0 11762.1 11944.3 10184.3 10290.3 10385.8 10445.9 10858.3 11057.7 11093.7 11422.8 11443.9 11499.5 9050.5 9073.4 9107.6 9127.0 9364.0 9795.4 9901.9 9924.0 9968.5 10076.4 05:12:56 INFO - PROCESS | 5999 | -------- Summary: end -------- 05:12:56 INFO - PROCESS | 5999 | 05:12:57 INFO - TEST-INFO | 5999: exit 0 05:12:57 INFO - TEST-OK | dromaeo_css | took 1111279ms 05:12:57 INFO - TEST-START | kraken 05:12:57 INFO - operating with platform_type : linux_ 05:12:57 INFO - Initialising browser for kraken test... 05:12:57 INFO - TEST-INFO | started process 6240 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Ly1Mv/profile http://localhost:56474/getInfo.html) 05:13:01 INFO - PROCESS | 6240 | 05:13:01 INFO - PROCESS | 6240 | (process:6314): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:13:01 INFO - PROCESS | 6240 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:13:01 INFO - PROCESS | 6240 | __metrics Screen width/height:1600/1200 05:13:01 INFO - PROCESS | 6240 | colorDepth:24 05:13:01 INFO - PROCESS | 6240 | Browser inner width/height: 1024/697 05:13:01 INFO - PROCESS | 6240 | __metrics 05:13:02 INFO - PROCESS | 6240 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:13:02 INFO - TEST-INFO | 6240: exit 0 05:13:02 INFO - Browser initialized. 05:13:02 INFO - Running cycle 1/1 for kraken test... 05:13:02 INFO - TEST-INFO | started process 6363 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Ly1Mv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:04 INFO - PROCESS | 6363 | 05:13:04 INFO - PROCESS | 6363 | (process:6424): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:13:14 INFO - PROCESS | 6363 | RSS: Main: 150827008 05:13:14 INFO - PROCESS | 6363 | 05:13:17 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56474/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:17 INFO - PROCESS | 6363 | RSS: Main: 151478272 05:13:17 INFO - PROCESS | 6363 | 05:13:20 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56474/tests/kraken/driver.html?testName=audio-dft) 05:13:20 INFO - PROCESS | 6363 | RSS: Main: 152162304 05:13:20 INFO - PROCESS | 6363 | 05:13:23 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56474/tests/kraken/driver.html?testName=audio-fft) 05:13:24 INFO - PROCESS | 6363 | RSS: Main: 146354176 05:13:24 INFO - PROCESS | 6363 | 05:13:26 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56474/tests/kraken/driver.html?testName=audio-oscillator) 05:13:27 INFO - PROCESS | 6363 | RSS: Main: 147546112 05:13:27 INFO - PROCESS | 6363 | 05:13:29 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:30 INFO - PROCESS | 6363 | RSS: Main: 147812352 05:13:30 INFO - PROCESS | 6363 | 05:13:33 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56474/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:33 INFO - PROCESS | 6363 | RSS: Main: 147197952 05:13:33 INFO - PROCESS | 6363 | 05:13:37 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56474/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:37 INFO - PROCESS | 6363 | RSS: Main: 148967424 05:13:37 INFO - PROCESS | 6363 | 05:13:40 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56474/tests/kraken/driver.html?testName=json-parse-financial) 05:13:41 INFO - PROCESS | 6363 | RSS: Main: 149180416 05:13:41 INFO - PROCESS | 6363 | 05:13:42 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:43 INFO - PROCESS | 6363 | RSS: Main: 148901888 05:13:43 INFO - PROCESS | 6363 | 05:13:45 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:45 INFO - PROCESS | 6363 | RSS: Main: 149164032 05:13:45 INFO - PROCESS | 6363 | 05:13:47 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:48 INFO - PROCESS | 6363 | RSS: Main: 149430272 05:13:48 INFO - PROCESS | 6363 | 05:13:50 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:51 INFO - PROCESS | 6363 | RSS: Main: 149803008 05:13:51 INFO - PROCESS | 6363 | 05:13:54 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:54 INFO - PROCESS | 6363 | RSS: Main: 148975616 05:13:54 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | Cycle 1(1): loaded http://localhost:56474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56474/tests/kraken/driver.html?testName=ai-astar) 05:13:56 INFO - PROCESS | 6363 | RSS: Main: 149012480 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | __start_tp_report 05:13:56 INFO - PROCESS | 6363 | _x_x_mozilla_page_load 05:13:56 INFO - PROCESS | 6363 | _x_x_mozilla_page_load_details 05:13:56 INFO - PROCESS | 6363 | |i|pagename|runs| 05:13:56 INFO - PROCESS | 6363 | |0;ai-astar;114;108;112;112;112;124;112;110;112;112 05:13:56 INFO - PROCESS | 6363 | |1;audio-beat-detection;150;133;153;169;137;155;144;128;161;131 05:13:56 INFO - PROCESS | 6363 | |2;audio-dft;161;162;162;163;161;161;161;164;167;164 05:13:56 INFO - PROCESS | 6363 | |3;audio-fft;72;73;71;72;76;156;76;71;73;74 05:13:56 INFO - PROCESS | 6363 | |4;audio-oscillator;96;97;142;97;98;95;151;97;96;140 05:13:56 INFO - PROCESS | 6363 | |5;imaging-gaussian-blur;110;111;111;110;110;110;109;110;110;110 05:13:56 INFO - PROCESS | 6363 | |6;imaging-darkroom;147;146;147;146;146;148;148;147;146;147 05:13:56 INFO - PROCESS | 6363 | |7;imaging-desaturate;96;97;96;98;97;96;96;97;97;97 05:13:56 INFO - PROCESS | 6363 | |8;json-parse-financial;59;59;56;57;58;58;56;57;55;57 05:13:56 INFO - PROCESS | 6363 | |9;json-stringify-tinderbox;67;68;69;68;71;70;67;69;70;68 05:13:56 INFO - PROCESS | 6363 | |10;stanford-crypto-aes;86;84;86;86;86;92;93;88;85;86 05:13:56 INFO - PROCESS | 6363 | |11;stanford-crypto-ccm;123;118;126;118;128;124;119;119;118;127 05:13:56 INFO - PROCESS | 6363 | |12;stanford-crypto-pbkdf2;153;156;153;154;157;156;158;163;145;160 05:13:56 INFO - PROCESS | 6363 | |13;stanford-crypto-sha256-iterative;71;69;70;70;71;71;68;70;67;70 05:13:56 INFO - PROCESS | 6363 | __end_tp_report 05:13:56 INFO - PROCESS | 6363 | __start_cc_report 05:13:56 INFO - PROCESS | 6363 | _x_x_mozilla_cycle_collect,787 05:13:56 INFO - PROCESS | 6363 | __end_cc_report 05:13:56 INFO - PROCESS | 6363 | __startTimestamp1452518036605__endTimestamp 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | ------- Summary: start ------- 05:13:56 INFO - PROCESS | 6363 | Number of tests: 14 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:4.24 (3.8%) stddev-sans-first:4.47 05:13:56 INFO - PROCESS | 6363 | Values: 114.0 108.0 112.0 112.0 112.0 124.0 112.0 110.0 112.0 112.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.50 stddev:13.76 (9.1%) stddev-sans-first:14.52 05:13:56 INFO - PROCESS | 6363 | Values: 150.0 133.0 153.0 169.0 137.0 155.0 144.0 128.0 161.0 131.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.96 (1.2%) stddev-sans-first:1.99 05:13:56 INFO - PROCESS | 6363 | Values: 161.0 162.0 162.0 163.0 161.0 161.0 161.0 164.0 167.0 164.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#3] audio-fft Cycles:10 Average:81.40 Median:73.00 stddev:26.27 (36.0%) stddev-sans-first:27.65 05:13:56 INFO - PROCESS | 6363 | Values: 72.0 73.0 71.0 72.0 76.0 156.0 76.0 71.0 73.0 74.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.50 stddev:23.25 (24.1%) stddev-sans-first:24.03 05:13:56 INFO - PROCESS | 6363 | Values: 96.0 97.0 142.0 97.0 98.0 95.0 151.0 97.0 96.0 140.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:13:56 INFO - PROCESS | 6363 | Values: 110.0 111.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:13:56 INFO - PROCESS | 6363 | Values: 147.0 146.0 147.0 146.0 146.0 148.0 148.0 147.0 146.0 147.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:13:56 INFO - PROCESS | 6363 | Values: 96.0 97.0 96.0 98.0 97.0 96.0 96.0 97.0 97.0 97.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.32 (2.3%) stddev-sans-first:1.22 05:13:56 INFO - PROCESS | 6363 | Values: 59.0 59.0 56.0 57.0 58.0 58.0 56.0 57.0 55.0 57.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.27 05:13:56 INFO - PROCESS | 6363 | Values: 67.0 68.0 69.0 68.0 71.0 70.0 67.0 69.0 70.0 68.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.00 stddev:2.97 (3.5%) stddev-sans-first:3.12 05:13:56 INFO - PROCESS | 6363 | Values: 86.0 84.0 86.0 86.0 86.0 92.0 93.0 88.0 85.0 86.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:4.06 (3.3%) stddev-sans-first:4.28 05:13:56 INFO - PROCESS | 6363 | Values: 123.0 118.0 126.0 118.0 128.0 124.0 119.0 119.0 118.0 127.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.50 stddev:4.84 (3.1%) stddev-sans-first:5.04 05:13:56 INFO - PROCESS | 6363 | Values: 153.0 156.0 153.0 154.0 157.0 156.0 158.0 163.0 145.0 160.0 05:13:56 INFO - PROCESS | 6363 | 05:13:56 INFO - PROCESS | 6363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 05:13:56 INFO - PROCESS | 6363 | Values: 71.0 69.0 70.0 70.0 71.0 71.0 68.0 70.0 67.0 70.0 05:13:56 INFO - PROCESS | 6363 | -------- Summary: end -------- 05:13:56 INFO - PROCESS | 6363 | 05:13:57 INFO - TEST-INFO | 6363: exit 0 05:13:57 INFO - TEST-OK | kraken | took 59970ms 05:13:57 INFO - TEST-START | v8_7 05:13:57 INFO - operating with platform_type : linux_ 05:13:57 INFO - Initialising browser for v8_7 test... 05:13:57 INFO - TEST-INFO | started process 6652 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOjVl4Z/profile http://localhost:56474/getInfo.html) 05:14:01 INFO - PROCESS | 6652 | 05:14:01 INFO - PROCESS | 6652 | (process:6726): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:14:01 INFO - PROCESS | 6652 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:14:01 INFO - PROCESS | 6652 | __metrics Screen width/height:1600/1200 05:14:01 INFO - PROCESS | 6652 | colorDepth:24 05:14:01 INFO - PROCESS | 6652 | Browser inner width/height: 1024/697 05:14:01 INFO - PROCESS | 6652 | __metrics 05:14:02 INFO - PROCESS | 6652 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:14:02 INFO - TEST-INFO | 6652: exit 0 05:14:02 INFO - Browser initialized. 05:14:02 INFO - Running cycle 1/1 for v8_7 test... 05:14:02 INFO - TEST-INFO | started process 6775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOjVl4Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:04 INFO - PROCESS | 6775 | 05:14:04 INFO - PROCESS | 6775 | (process:6833): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:14:14 INFO - PROCESS | 6775 | RSS: Main: 150388736 05:14:14 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | Cycle 1(1): loaded http://localhost:56474/tests/v8_7/run.html (next: http://localhost:56474/tests/v8_7/run.html) 05:14:37 INFO - PROCESS | 6775 | RSS: Main: 146939904 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | __start_tp_report 05:14:37 INFO - PROCESS | 6775 | _x_x_mozilla_page_load 05:14:37 INFO - PROCESS | 6775 | _x_x_mozilla_page_load_details 05:14:37 INFO - PROCESS | 6775 | |i|pagename|runs| 05:14:37 INFO - PROCESS | 6775 | |0;Richards;166.38935108153078 05:14:37 INFO - PROCESS | 6775 | |1;DeltaBlue;189.28639030853682 05:14:37 INFO - PROCESS | 6775 | |2;Encrypt;279.72027972027973 05:14:37 INFO - PROCESS | 6775 | |3;Decrypt;5263.1578947368425 05:14:37 INFO - PROCESS | 6775 | |4;RayTrace;1072.961373390558 05:14:37 INFO - PROCESS | 6775 | |5;Earley;762.7765064836003 05:14:37 INFO - PROCESS | 6775 | |6;Boyer;12407.407407407407 05:14:37 INFO - PROCESS | 6775 | |7;RegExp;41040 05:14:37 INFO - PROCESS | 6775 | |8;Splay;566.2514156285391 05:14:37 INFO - PROCESS | 6775 | |9;NavierStokes;4854.368932038835 05:14:37 INFO - PROCESS | 6775 | __end_tp_report 05:14:37 INFO - PROCESS | 6775 | __startTimestamp1452518077424__endTimestamp 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | ------- Summary: start ------- 05:14:37 INFO - PROCESS | 6775 | Number of tests: 10 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 166.4 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#1] DeltaBlue Cycles:1 Average:189.29 Median:189.29 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 189.3 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 279.7 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 5263.2 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 1073.0 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#5] Earley Cycles:1 Average:762.78 Median:762.78 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 762.8 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 12407.4 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#7] RegExp Cycles:1 Average:41040.00 Median:41040.00 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 41040.0 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#8] Splay Cycles:1 Average:566.25 Median:566.25 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 566.3 05:14:37 INFO - PROCESS | 6775 | 05:14:37 INFO - PROCESS | 6775 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:14:37 INFO - PROCESS | 6775 | Values: 4854.4 05:14:37 INFO - PROCESS | 6775 | -------- Summary: end -------- 05:14:37 INFO - PROCESS | 6775 | 05:14:38 INFO - TEST-INFO | 6775: exit 0 05:14:38 INFO - TEST-OK | v8_7 | took 40703ms 05:14:38 INFO - SUITE-END | took 1211s 05:14:38 INFO - Completed test suite (00:20:12) 05:14:38 INFO - Working with test: dromaeo_css 05:14:38 INFO - Generating results file: dromaeo_css 05:14:38 INFO - Working with test: kraken 05:14:38 INFO - Generating results file: kraken 05:14:38 INFO - javascript benchmark 05:14:38 INFO - Working with test: v8_7 05:14:38 INFO - Generating results file: v8_7 05:14:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:14:38 INFO - process_Request line: dromaeo_css 6789.81 graph.html#tests=[[72,64,43]] 05:14:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:38 INFO - process_Request line: kraken 1527.70 graph.html#tests=[[232,64,43]] 05:14:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:38 INFO - process_Request line: v8_7 20303.38 graph.html#tests=[[230,64,43]] 05:14:38 INFO - RETURN: dromaeo_css: 6789.81 05:14:38 INFO - RETURN: kraken: 1527.70 05:14:38 INFO - RETURN: v8_7: 20303.38 05:14:38 INFO - javascript benchmark 05:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.297914458819, 3210.9518357224633, 3225.5000474926396, 3250.171206342383, 3262.8531716072775, 5225.921611175831, 5230.058589453897, 5237.3715154181455, 5241.973790131049, 5242.21366794981, 5213.608979326546, 5244.082285600014, 5256.159014557672, 5272.446393128724, 5287.68273903566, 4515.841945531907, 4779.139754844118, 4961.553460188582, 4967.453580106186, 4969.577585905203, 4726.881827954311, 4884.340614017097, 4936.555709986101, 4943.6539442239055, 4947.084789313988, 4750.049990001996, 4786.353842231307, 4884.609231261491, 4885.780139893678, 4902.730349830758, 4756.881077973044, 4801.2798080287885, 4819.397575303087, 4842.055799119174, 4845.6123510119105, 4705.3647757552635, 4784.234522476422, 4797.568218860284, 4814.325994360793, 4837.419509658828, 5082.79668813247, 5127.9230811537855, 5136.717480538568, 5151.536361727425, 5173.405058418292, 5592.552595792326, 5604.943950560483, 5620.85947851307, 5638.943610563882, 5676.517496012844, 5677.971610141964, 5697.487226149667, 5719.456651618089, 5743.971280143614, 5768.3654797972185, 5362.383325917531, 5364.249005139322, 5378.413368056433, 5384.865378365533, 5393.946060539344, 5802.187693722883, 5857.619254748428, 5858.53131749459, 5860.09168578871, 5887.411258874078, 5470.452954704578, 5538.556915446755, 5548.334199896039, 5631.436856314418, 5676.0066988276885, 5632.633878797947, 5634.211210430543, 5635.830925072254, 5635.887282254332, 5639.605227634108, 5554.250176226158, 5574.804881829116, 5579.246801681802, 5598.1322894951345, 5615.9157612635845, 5449.155380915964, 5609.971950140305, 5646.97176514123, 5657.632253903483, 5676.403977582295, 4381.211381951216, 4390.473143222834, 4392.05570802279, 4398.252297109435, 4426.026274219666, 3900.6294402031763, 3927.116398810302, 3935.74417662851, 3950.1704642025497, 3986.8405263789705, 5292.92060619091, 5359.330083739533, 5367.2485851980755, 5377.569794416438, 5386.272853164851, 5669.801556945487, 5677.943220567824, 5726.169705392695, 5736.483716465538, 5746.569007324468, 5289.312389389354, 5341.038613049611, 5350.143976963667, 5352.304200453916, 5411.377691565521, 4765.785539650724, 4769.976150119297, 4776.450708168605, 4776.474587795409, 4792.353032340589, 5933.288005439289, 5934.198883150806, 5948.702564871739, 5950.761969521257, 5962.5826192167, 5676.233708449472, 5745.540356771365, 5753.62601430914, 5771.365149833431, 5776.335721392094, 5715.742791574472, 5792.420757924174, 5820.923129221108, 5849.883002340014, 5880.676562789087, 5631.549476041989, 5658.953093677683, 5666.716664166693, 5670.036093864135, 5681.659100453986, 5716.885662286814, 5747.281589801275, 5751.511121554715, 5756.3380211276235, 5757.078867381367, 5481.123020316731, 5595.244641973444, 5595.552355811444, 5597.748101335368, 5607.915881261702, 5628.0432326505415, 5633.38032816398, 5639.295088113986, 5643.209950607001, 5679.00617391963, 5473.562115030708, 5508.118701007819, 5516.696581688046, 5528.778848846001, 5531.529819965348, 5403.486668766461, 5483.670979741229, 5520.91718624229, 5554.500094991308, 5619.999006013682, 5524.558035357242, 5533.197686335539, 5533.335999680065, 5534.584906132137, 5536.501714845684], "unit": "score", "name": "dojo.html", "value": 5242.396685060606}, {"lowerIsBetter": false, "replicates": [508.7761384990604, 520.323579346849, 530.6206062665195, 546.3007350591245, 560.3527925246342, 35263.47104793427, 35706.642933570656, 35810.92567222981, 35886.8205658972, 35931.640683593156, 38603.61396386042, 38647.0, 38933.610663893356, 39090.0, 39120.0, 8521.190486903733, 8660.177283158122, 8670.913290867074, 8680.609372578218, 8716.694915677952, 8367.748967530984, 8543.95728021359, 8573.699920502784, 8705.608247628841, 8747.125287471266, 8676.089010653885, 8756.299496040301, 8798.340124490656, 8817.074207208247, 8834.514101724402, 8651.134886511361, 8740.912590874104, 8753.431026983257, 8779.341549383822, 8786.428882122706, 8530.616122274512, 8610.311175106039, 8640.827183456297, 8658.393912426132, 8660.393772435931, 38444.42333365002, 38488.615113848784, 38507.42238866419, 38748.22503549942, 38808.0, 3268.6077670679433, 3280.114369120348, 3301.339732053575, 3316.9004929852144, 3331.4336562784383, 28733.0, 29308.12075637713, 29365.853170734008, 29500.852495737385, 30058.84970575133, 3782.8108594570162, 4028.637422631977, 4077.4699289092523, 4113.280175969194, 4153.501579810412, 266196.0, 268771.0, 269548.0, 270164.0, 270418.64790676115, 40760.59239407568, 41165.588344116775, 54642.180367294524, 55071.0, 55096.44903550993, 38962.0, 39291.41062884059, 39467.0, 39533.209335813124, 39556.2088758229, 14093.0, 14122.505712300226, 14123.646908827155, 14209.147451152758, 14238.430462781373, 11396.430178491042, 11444.542218311175, 11503.137264705181, 11546.307221566733, 11602.419879006016, 13549.458021679022, 13587.0, 13947.721045579032, 13957.58127256184, 13988.860111398959, 5652.576056795675, 5705.857353566111, 5706.487780738108, 5810.21562089121, 5828.562857785683, 947.4078700811992, 1003.4180175498193, 1035.8601588785418, 1046.283295942282, 1048.3185929145964, 27740.0, 28373.43253134926, 28592.714072859006, 28660.570091448644, 28831.71168288332, 1025.5385076715509, 1082.3938594387168, 1103.9282446640943, 1118.2731224704007, 1119.7144728094283, 15828.44600438979, 16366.672666546603, 16647.83352166487, 16757.748633770505, 16969.915150424167, 373907.0, 375735.0, 377771.0, 378972.0, 381006.0, 51925.0, 52089.739551302, 52256.0, 52362.73818630959, 52567.474325256255, 1262.6338361875137, 1262.9368531573384, 1323.9602811915659, 1333.0601925642204, 1333.6332508560224, 28434.28914277077, 29153.271168220963, 29440.41119177647, 29627.0, 29743.25641858971, 43524.34713479237, 43549.0, 43889.34165987577, 43955.560444396426, 44057.339139913565, 290152.0, 291074.0, 295278.0, 295367.75477348955, 295852.0, 31042.0, 42019.1596168081, 42471.78764106159, 42545.78727106345, 42647.786761065996, 38063.61936380711, 38763.80618096892, 38881.2223755529, 39047.219055619295, 39106.2178756429, 32957.67042329642, 32986.67013329836, 33152.83423582867, 33221.33557328791, 33776.0, 32878.506822398165, 37348.0, 37709.20266859811, 38339.80830095831, 41887.790561047, 34809.65190348064, 34950.82524587361, 35090.473642895886, 35259.47110793289, 35287.117822053624, 30779.384412312076, 32069.35861282808, 32156.51765223477, 32904.34191316208, 32954.5056824143, 24573.877130614233, 25606.8719656408, 26383.208503744918, 27024.32439189036, 27038.864805676632], "unit": "score", "name": "ext.html", "value": 17818.008229901392}, {"lowerIsBetter": false, "replicates": [362.24471975930186, 362.5721648454824, 363.7871844970692, 364.22965428119534, 369.0165708387148, 16399.098049607266, 16643.50069497914, 16947.49157525273, 17077.658446831058, 17704.557386065353, 15160.848391516081, 15309.0, 15586.688266234669, 15593.610159745984, 15669.45156919508, 4596.287575425815, 4755.809767609291, 4788.5450882166315, 4798.352222449959, 4800.399950006249, 4607.58531732144, 4755.90488190236, 4995.300657907896, 4999.075171093359, 5005.824796132136, 4969.925451118218, 4993.525615066563, 5013.824516141935, 5196.168613021917, 5200.115980283361, 5172.327597412331, 5202.531772140525, 5237.45006774289, 5499.50504454601, 6089.117078023662, 5369.865753356158, 5399.811006614789, 5405.405405405402, 5407.270018547485, 5413.972930135364, 14581.19803410812, 18870.811291887043, 19357.903210483997, 19511.0, 19619.117139728747, 1961.852861035428, 2054.5377290109755, 2148.9247876324253, 2186.3768825884545, 2216.7229096362953, 9320.0, 9349.672761453385, 9467.0, 10298.7425314367, 13028.739425211537, 1796.8293012163824, 1805.2417984446563, 1836.494963884929, 1851.333519932823, 1919.7216403621537, 54912.0, 55216.44783552153, 55573.0, 56460.43539564634, 57057.0, 9573.18627916621, 9811.411315321104, 10040.899591004143, 10074.143697785623, 10128.848067278997, 13015.934920325337, 13052.934735326262, 13131.0, 13131.474741010443, 13139.34303284832, 7527.661255243527, 7544.132424771222, 7560.697572097164, 7591.962040189764, 7593.696252149963, 7208.24313447091, 7281.635918204069, 7299.781006569811, 7312.817179570553, 7375.44684148691, 4340.479142502857, 4367.017421080295, 4374.234508960919, 4385.758783266951, 4413.095315460323, 1770.9645807083787, 1803.4048763907879, 1851.990740046318, 2953.837538935379, 2959.926001849971, 847.2501835875295, 856.8157846063126, 918.3342076994126, 920.4845286639503, 1048.9947550262352, 15808.288627011812, 16243.0, 16283.755743663854, 16650.916745416194, 16716.832831671527, 873.8121303919561, 902.4072512016296, 914.4147745442922, 930.134974473746, 936.4334577580602, 9424.95287523558, 9449.0, 9555.522223888778, 9580.425174489414, 9779.0, 393784.0, 409816.0, 409886.0, 413176.0, 413707.0, 68440.31559684439, 70469.6476517614, 70689.64655176795, 71083.0, 71184.64407677928, 1079.5034284229343, 1080.7352198711367, 1148.3167515328366, 1159.3797318434597, 1164.6214980131492, 14427.42290308376, 14532.128072315694, 14595.635109121931, 14638.414463421344, 14854.405823766929, 31732.841335794095, 31919.202019949687, 32780.67219327872, 32937.17657058497, 33007.174820629676, 41311.793441032605, 41340.37989430101, 42398.36402453904, 43374.78312608417, 43417.131657366044, 6504.544681872224, 6986.0219569259325, 7159.57042577447, 7276.381507571704, 7486.101667799899, 3819.3125237457525, 7824.78715799052, 8465.57672116404, 10085.243606729671, 10282.331648442827, 9170.03714609983, 9701.320907536405, 9728.17310528613, 9821.263405244492, 9860.802783944138, 8515.446495977742, 8544.40189186751, 9519.00050494688, 9709.609819379248, 9780.070893265129, 8940.329475289509, 9421.434713917188, 9809.901900980898, 9903.0, 10186.490675466346, 7169.247229040876, 7254.528455650366, 7282.2353652867805, 7387.298206670358, 7389.778306650809, 8182.386321025828, 8539.530325832138, 9372.297077719062, 9806.362586432144, 9921.603135874773], "unit": "score", "name": "jquery.html", "value": 7960.602219201987}, {"lowerIsBetter": false, "replicates": [1435.9712805743886, 1452.869241768241, 1575.2438829361906, 1704.3779020657464, 1729.1613567419806, 7108.537945033576, 7231.7830465086, 7300.853982920345, 7318.085239345089, 7373.336399724024, 7334.816629584263, 7362.153352364479, 7398.408127349812, 7425.405967522599, 7477.513961592493, 2283.2693538067824, 2303.7120359955006, 2306.6885970394032, 2320.6867072945106, 2321.4080409495555, 2340.531893621274, 2364.160722943356, 2367.396313939943, 2369.727481339642, 2374.857508549484, 2295.701558797354, 2336.4742932840145, 2354.058376649337, 2358.5377066218966, 2360.504294098233, 2326.639370897505, 2346.8474549154334, 2347.5187586544716, 2349.236498138112, 2356.528694261146, 2374.4063984004, 2384.0106355862295, 2390.4262976885598, 2392.294273189413, 2402.8318017738766, 7230.819229519251, 7239.457040721967, 7249.746258880914, 7252.347288743986, 7253.782386528413, 4548.454185497729, 4720.905581888377, 4724.055188962221, 4730.526947305277, 4730.787114579852, 2918.8248705077763, 3111.1133327001694, 3119.407312610597, 3131.812091274508, 3137.7646676499126, 972.7276362618478, 979.2704435195825, 996.227923359395, 1001.3691374434133, 1033.5659023210194, 9869.309148359618, 9875.753106172331, 9929.106380425725, 9931.602735890556, 9932.205423566169, 4059.7767122808527, 4113.691473139466, 4113.85601503946, 4118.114605359862, 4310.051788606502, 8158.0, 8209.179082091863, 8226.0, 8226.383021273428, 8233.547154906537, 4730.290456431563, 4742.762861856893, 4749.667523273338, 4764.785584648699, 4771.785269662873, 4343.131373725204, 4355.673324500675, 4379.671524635665, 4388.122375524844, 4398.076403955141, 3350.8157051361923, 3364.4280472319765, 3388.881389151368, 3403.761736678409, 3419.8461069251944, 992.4442312305132, 997.3816233935007, 998.3909815012836, 1009.0464511037, 1040.3341861208833, 932.9067093290753, 942.1803031362622, 1097.9231453798318, 1145.2212495502972, 1307.2483322089836, 6921.204061532888, 6922.688479018356, 6944.270851560615, 6967.198772141269, 7001.299870012958, 625.9874802503924, 627.5795217204484, 639.491604174673, 640.5708175522411, 771.4831063187678, 5388.622796404293, 5412.242286079873, 5437.13005919051, 5450.427705090988, 5472.835814925558, 8773.0, 8790.164934331227, 8959.0, 9004.054574269607, 9040.0, 8828.073052329413, 8833.734987950373, 8866.73399798007, 8872.979607345109, 8936.821263574691, 6745.494087943423, 6884.793456196322, 6903.275156108737, 7027.472939529555, 7054.259302773237, 6883.965580172067, 6917.757878474229, 6919.135108111486, 6951.02685624003, 6961.234264231032, 7854.764357069297, 8158.796030099295, 8214.958925205336, 8221.876671850046, 8262.091169971178, 8204.220599043081, 8366.83266334682, 8395.412321137706, 8436.831263374821, 8481.10948350439, 6620.337966203341, 6664.533482656361, 6769.458443324621, 6779.508508128204, 6790.117284752951, 7032.507724459443, 7065.364117229474, 7087.114110736158, 7089.716411343695, 7108.0, 5871.266091738533, 6620.536562440583, 6746.359095885883, 6880.931190688229, 6935.514513984174, 6518.57629254097, 6535.542512024303, 6618.569792963442, 6643.2360278568585, 6654.101696271135, 6506.837329066811, 6577.309382514767, 6620.470362370903, 6629.105070815378, 6631.734730610721, 6207.937920620917, 6284.214473190851, 6295.5907865988565, 6305.0, 6307.558470906993, 6153.938460615515, 6326.746930122744, 6346.397092276226, 6359.523035772243, 6369.108324834619], "unit": "score", "name": "mootools.html", "value": 4288.01721786011}, {"lowerIsBetter": false, "replicates": [334.4164433064303, 343.6735101653429, 354.10588264631804, 357.545916685809, 358.99282014359727, 6207.286162091361, 6255.874882502348, 6261.499080073595, 6295.716692748826, 6396.200474940632, 6185.0722391641275, 6223.564350495456, 6226.595271307362, 6228.096925945735, 6291.811245662626, 4766.571008609225, 4768.094062128202, 4768.451628062765, 4772.212584923492, 4775.021120670272, 4766.332713420124, 4768.761561921908, 4777.498362671921, 4781.641376896747, 4782.163121453732, 4520.547945205486, 4652.604528615072, 4657.324687920266, 4668.789904454307, 4735.644826637998, 4637.930431043537, 4642.744649044318, 4644.744539050351, 4648.86053418398, 4652.348671186037, 3950.604939506055, 3978.8806335809973, 3994.9201015979515, 4003.559608443069, 4017.27689015977, 5916.467517923407, 5923.466887980059, 5926.614770039977, 5930.9406905931255, 5931.733072011727, 5326.440723723992, 5389.272448219519, 5479.013777520045, 5485.725713714338, 5491.313585801775, 6561.704723287464, 6569.37590928861, 6570.441512471446, 6571.507136964747, 6583.506237032194, 4534.093181363741, 4534.5692159245145, 4537.659675524316, 4545.954540454586, 4553.772311384418, 6675.499337549703, 6847.2125705544, 6919.446444284496, 6922.619255940921, 6930.61881596512, 4599.563041511051, 4636.884077898079, 4649.767511624405, 4658.557437043475, 4673.836415725501, 4701.059788042337, 4715.4577223619035, 4724.929126063112, 4727.456342520585, 4734.431868175772, 5468.562514998791, 5472.863178420492, 5474.534664553557, 5475.178723191473, 5480.369757477862, 6426.4216220540375, 6596.406323430819, 6620.073189753439, 6641.369069938348, 6652.866942661217, 1639.5737108351914, 1685.7302831547138, 1735.982640173582, 1737.3050779688226, 1741.1903464888887, 1148.1618418554501, 1174.6593487888417, 1188.1385995153444, 1188.9227200231958, 1193.0813273779142, 6161.507079433634, 6179.28938172107, 6205.5345849061505, 6215.223097112861, 6237.532185086136, 6624.304448032984, 6667.0, 6674.833129171712, 6719.596824190564, 6736.865262694719, 6065.75736970525, 6143.723532441051, 6160.168377269011, 6195.132681424604, 6197.659128747962, 3632.7093832493338, 3643.890683279506, 3648.0, 3657.122290650278, 3663.19409729859, 6958.79123626292, 6988.231294557595, 7010.649467526705, 7013.473989450812, 7029.648517574101, 6723.125993620798, 6846.178458584902, 6868.450523958071, 6880.724771009203, 6885.277045910208, 6998.195207551095, 7003.194632617212, 7008.229094799568, 7008.369246767816, 7010.983407405897, 6703.798886033427, 6704.899426508508, 6705.932940670531, 6714.362135597111, 6720.731170753115, 6524.217093948757, 6648.7340506379205, 6649.368310010541, 6652.0, 6655.700493477708, 6964.408025317702, 7001.704684633359, 7004.579725216503, 7010.193827709879, 7012.1935977363255, 4778.187708089703, 4786.329913812138, 4792.0, 4812.302216178565, 4816.494268101939, 6635.369639884203, 6690.732370705117, 6735.158105236846, 6737.898931515933, 6826.112605361272, 6671.366220209073, 6688.097106890507, 6696.7656132035145, 6698.39714425704, 6717.16035495563, 6630.071789949508, 6649.63427011519, 6654.234763002317, 6664.766733164316, 6670.83322916931, 6444.677766111769, 6527.477801775752, 6541.6075035498025, 6548.345165483413, 6566.146400967844, 6684.0642310075655, 6699.899501507579, 6715.0, 6716.361945615159, 6738.124043874461, 6510.381513756186, 6529.771457998947, 6542.8364290893105, 6545.247296560957, 6551.21385433751], "unit": "score", "name": "prototype.html", "value": 4964.8203567195105}, {"lowerIsBetter": false, "replicates": [732.8607564562733, 743.8437928035113, 788.3653658804661, 815.9755207343782, 851.0893344121793, 12940.805887911678, 12980.221186728802, 12997.870021299785, 13075.476980920763, 13094.672633184175, 12516.249025058503, 12556.18384804987, 12607.558735444261, 12610.243385396883, 12614.936925315384, 655.8852200864853, 658.1049772309655, 765.865973454646, 779.154617240295, 787.4173111897212, 777.8872063550782, 783.0564170174925, 784.7684932944767, 786.6931896560346, 787.6455594982281, 827.4001349021971, 829.3613917283687, 830.9459885107478, 832.4755404095412, 834.4117397234935, 822.8230930349973, 824.1593574553922, 827.1686954610608, 828.0312034919159, 828.5939889454185, 608.2974164839617, 611.10778263735, 612.7640858269598, 612.8437248501648, 616.5098746496546, 13120.60638180856, 13139.60581182566, 13161.341932903317, 13179.670508237275, 13187.736245275137, 12772.425240864184, 12973.610791676265, 13160.6709832254, 13337.799933001013, 13371.0, 10103.747406314827, 10182.28723989321, 10202.693919182362, 10386.636467723594, 10681.198910081697, 3565.893023209308, 3618.8914332570066, 3630.110622897381, 3650.0327413235514, 3687.575928768199, 41381.172376552604, 41688.374674379906, 41728.37407438891, 41759.1648167038, 41761.58238417607, 9192.770180745534, 9433.0, 9445.102715242041, 9546.95226523863, 9762.316637835283, 17415.303387864344, 17507.73738393925, 17552.94682319065, 17624.118794060247, 17764.200610972537, 7346.889796653055, 7430.182679905206, 7550.962245188739, 7605.771826845204, 7610.733624323122, 4390.165868484977, 4392.31919052541, 4407.933880991788, 4457.108578284357, 4467.285234362486, 2984.865681044358, 2992.1771512834143, 2994.520876659724, 2997.3405850712807, 3003.384306217264, 556.5130510803048, 556.9331680198402, 561.4497792163702, 571.8456016875421, 575.3211210771246, 569.4789267819981, 644.365300179323, 680.6324584724292, 693.8196069022091, 693.8889777635655, 8080.27277545012, 8115.634796434175, 8285.50286982783, 8475.152484751476, 9520.8571871422, 548.8106603221883, 590.4302348233974, 599.8530360061812, 611.996940015306, 691.6368906324119, 4159.604837540429, 4225.936610950838, 4338.0, 4520.163769702615, 4569.885752856205, 51794.22308665373, 52219.73890130525, 52709.7364513175, 58264.0, 60299.0, 48039.0, 48740.75629621829, 48810.75594622075, 49035.50964490381, 50071.0, 45117.54882451199, 45740.0, 45881.0, 46416.303755443696, 46597.30104048442, 8779.34154938395, 8946.57434329518, 9050.0, 9200.125988031126, 9228.630854766003, 31846.522302165024, 32580.0, 33363.1659208512, 34176.316473670886, 34197.145071373416, 40100.0, 40412.79793601013, 41598.37602436027, 42520.362194566485, 43016.784916076474, 11194.216404851582, 11374.886251137383, 11423.885761142283, 11565.0, 11698.532058717896, 12176.452059657513, 12200.206986545845, 12212.75574488523, 12390.62828115158, 12854.293013884326, 11080.390578517936, 11430.0, 11439.0, 11762.059035277329, 11944.283342999448, 10184.287099902936, 10290.331128476626, 10385.844212336971, 10445.895541044492, 10858.34849909008, 11057.723556911142, 11093.667189984313, 11422.771544569228, 11443.942780286045, 11499.482523286304, 9050.547472626211, 9073.410228335137, 9107.590158442754, 9126.954365228132, 9364.0, 9795.363301385387, 9901.900980990098, 9923.950380248052, 9968.50157492108, 10076.395416275047], "unit": "score", "name": "yui.html", "value": 6188.915062260623}], "name": "dromaeo_css", "value": 6789.811891313563}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 112.0, 112.0, 112.0, 124.0, 112.0, 110.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [150.0, 133.0, 153.0, 169.0, 137.0, 155.0, 144.0, 128.0, 161.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 164.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 72.0, 76.0, 156.0, 76.0, 71.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 97.0, 98.0, 95.0, 151.0, 97.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 98.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 56.0, 57.0, 58.0, 58.0, 56.0, 57.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 71.0, 70.0, 67.0, 69.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 86.0, 86.0, 92.0, 93.0, 88.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [123.0, 118.0, 126.0, 118.0, 128.0, 124.0, 119.0, 119.0, 118.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [153.0, 156.0, 153.0, 154.0, 157.0, 156.0, 158.0, 163.0, 145.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.5}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 70.0, 71.0, 71.0, 68.0, 70.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1527.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [189.28639030853682], "unit": "score", "name": "DeltaBlue", "value": 349.30139399999996}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [762.7765064836003], "unit": "score", "name": "Earley", "value": 873.732993}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [41040.0], "unit": "score", "name": "RegExp", "value": 22.197490253411285}, {"lowerIsBetter": false, "replicates": [566.2514156285391], "unit": "score", "name": "Splay", "value": 143.913106}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20303.379294126553}]} 05:14:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20303.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6789.81"}}} 05:14:38 INFO - Return code: 0 05:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:14:38 INFO - # TBPL SUCCESS # 05:14:38 INFO - Running post-action listener: _resource_record_post_action 05:14:38 INFO - Running post-run listener: _resource_record_post_run 05:14:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 321187840; Read time: 0; Write time: 282400 05:14:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 933888; Read time: 0; Write time: 44 05:14:39 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 319275008; Read time: 0; Write time: 282352 05:14:39 INFO - Running post-run listener: _upload_blobber_files 05:14:39 INFO - Blob upload gear active. 05:14:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:14:39 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:14:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:14:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:14:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:40 INFO - (blobuploader) - INFO - Done attempting. 05:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:41 INFO - (blobuploader) - INFO - Done attempting. 05:14:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:42 INFO - Return code: 0 05:14:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:14:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0739694369e50cfd0f1456c7c5de83732ee06f2bf6aae6d937b544d963de222234a84268d2c1d083a5f9e961347d2783733dcfed18145c2ab38be629cbe35838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06840dc8de74061ee642451ba2de78a9cf3dc6dc4060d3a443183a12020cea4bb9d608f2767005c88a5719e03205e645b4f917d516f8e30f562dc10a3f6f014"} 05:14:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:14:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:14:42 INFO - Contents: 05:14:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0739694369e50cfd0f1456c7c5de83732ee06f2bf6aae6d937b544d963de222234a84268d2c1d083a5f9e961347d2783733dcfed18145c2ab38be629cbe35838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06840dc8de74061ee642451ba2de78a9cf3dc6dc4060d3a443183a12020cea4bb9d608f2767005c88a5719e03205e645b4f917d516f8e30f562dc10a3f6f014"} 05:14:42 INFO - Copying logs to upload dir... 05:14:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.302293 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-11 05:14:41.938094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:14:41.942167) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0739694369e50cfd0f1456c7c5de83732ee06f2bf6aae6d937b544d963de222234a84268d2c1d083a5f9e961347d2783733dcfed18145c2ab38be629cbe35838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06840dc8de74061ee642451ba2de78a9cf3dc6dc4060d3a443183a12020cea4bb9d608f2767005c88a5719e03205e645b4f917d516f8e30f562dc10a3f6f014"} build_url:https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/QcOqxtqJTpmYaK1fMv_UcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0739694369e50cfd0f1456c7c5de83732ee06f2bf6aae6d937b544d963de222234a84268d2c1d083a5f9e961347d2783733dcfed18145c2ab38be629cbe35838", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06840dc8de74061ee642451ba2de78a9cf3dc6dc4060d3a443183a12020cea4bb9d608f2767005c88a5719e03205e645b4f917d516f8e30f562dc10a3f6f014"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:14:41.966802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:14:41.967124) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452516809.653818-766064561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:14:42.051714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:14:42.052051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:14:42.052366) ========= ========= Total master_lag: 0.23 =========