builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1451998764.69 results: success (0) buildid: 20160105023037 builduid: 99e04f5b654d4a2cb0ceb848f9b11650 revision: 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.690667) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.691083) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.691370) ========= 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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.715086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.715355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.749548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.749822) ========= 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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.800669) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.800937) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.801555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.801842) ========= 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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 04:59:25-- 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% 224M=0s 2016-01-05 04:59:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.984177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:24.984452) ========= 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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022476 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.042056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 04:59:25.042356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 --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 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 --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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 04:59:25,721 truncating revision to first 12 chars 2016-01-05 04:59:25,721 Setting DEBUG logging. 2016-01-05 04:59:25,721 attempt 1/10 2016-01-05 04:59:25,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0bea3bcf7946?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 04:59:26,697 unpacking tar archive at: fx-team-0bea3bcf7946/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 04:59:26.346614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:26.346913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:26.357243) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:26.357594) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:26.358333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-01-05 04:59:26.358626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:27 INFO - MultiFileLogger online at 20160105 04:59:27 in /builds/slave/test-pgo 04:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:59:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:59:27 INFO - {'append_to_log': False, 04:59:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:59:27 INFO - 'blob_upload_branch': 'Fx-Team', 04:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:59:27 INFO - 'branch': 'Fx-Team', 04:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:27 INFO - 'config_files': ('talos/linux_config.py',), 04:59:27 INFO - 'default_actions': ('clobber', 04:59:27 INFO - 'read-buildbot-config', 04:59:27 INFO - 'download-and-extract', 04:59:27 INFO - 'populate-webroot', 04:59:27 INFO - 'create-virtualenv', 04:59:27 INFO - 'install', 04:59:27 INFO - 'run-tests'), 04:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:27 INFO - 'download_minidump_stackwalk': True, 04:59:27 INFO - 'download_symbols': 'ondemand', 04:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:27 INFO - 'installer_path': 'installer.exe', 04:59:27 INFO - 'log_level': 'info', 04:59:27 INFO - 'log_name': 'talos', 04:59:27 INFO - 'log_to_console': True, 04:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:27 INFO - 'opt_config_files': (), 04:59:27 INFO - 'pip_index': False, 04:59:27 INFO - 'sps_profile': False, 04:59:27 INFO - 'sps_profile_interval': 0, 04:59:27 INFO - 'suite': 'dromaeojs', 04:59:27 INFO - 'system_bits': '32', 04:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:27 INFO - 'title': 'talos-linux64-ix-035', 04:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:27 INFO - 'use_talos_json': True, 04:59:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:27 INFO - 'work_dir': 'build'} 04:59:27 INFO - ##### 04:59:27 INFO - ##### Running clobber step. 04:59:27 INFO - ##### 04:59:27 INFO - Running pre-action listener: _resource_record_pre_action 04:59:27 INFO - Running main action method: clobber 04:59:27 INFO - rmtree: /builds/slave/test-pgo/build 04:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:59:27 INFO - Running post-action listener: _resource_record_post_action 04:59:27 INFO - ##### 04:59:27 INFO - ##### Running read-buildbot-config step. 04:59:27 INFO - ##### 04:59:27 INFO - Running pre-action listener: _resource_record_pre_action 04:59:27 INFO - Running main action method: read_buildbot_config 04:59:27 INFO - Using buildbot properties: 04:59:27 INFO - { 04:59:27 INFO - "project": "", 04:59:27 INFO - "product": "firefox", 04:59:27 INFO - "script_repo_revision": "production", 04:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:59:27 INFO - "repository": "", 04:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:59:27 INFO - "buildid": "20160105023037", 04:59:27 INFO - "pgo_build": "True", 04:59:27 INFO - "basedir": "/builds/slave/test-pgo", 04:59:27 INFO - "buildnumber": 871, 04:59:27 INFO - "slavename": "talos-linux64-ix-035", 04:59:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:59:27 INFO - "platform": "ubuntu64_hw", 04:59:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:59:27 INFO - "branch": "fx-team", 04:59:27 INFO - "repo_path": "integration/fx-team", 04:59:27 INFO - "revision": "0bea3bcf7946270ce90bf34cb78827fbdfee2e56", 04:59:27 INFO - "stage_platform": "linux64-pgo", 04:59:27 INFO - "builduid": "99e04f5b654d4a2cb0ceb848f9b11650", 04:59:27 INFO - "slavebuilddir": "test" 04:59:27 INFO - } 04:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:59:27 INFO - Running post-action listener: _resource_record_post_action 04:59:27 INFO - ##### 04:59:27 INFO - ##### Running download-and-extract step. 04:59:27 INFO - ##### 04:59:27 INFO - Running pre-action listener: _resource_record_pre_action 04:59:27 INFO - Running main action method: download_and_extract 04:59:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:59:27 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:59:27 INFO - https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json 04:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json 04:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:59:36 INFO - Downloaded 1302 bytes. 04:59:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:59:36 INFO - Using the following test package requirements: 04:59:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:59:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'jsshell-linux-x86_64.zip'], 04:59:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:59:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:59:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:59:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:59:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:59:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:59: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:59:36 INFO - https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:00 INFO - Downloaded 23199261 bytes. 05:00:00 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 05:00:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:00:00 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 05:00:01 INFO - Return code: 0 05:00:01 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 05:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:01 INFO - https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:03 INFO - Downloaded 23199261 bytes. 05:00:03 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 05:00:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:00:03 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 05:00:05 INFO - Return code: 0 05:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:05 INFO - https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:05 INFO - Downloaded 11132285 bytes. 05:00:05 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 05:00:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:05 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 05:00:06 INFO - Return code: 0 05:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:06 INFO - https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:00:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:00:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:00:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/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 05:00:13 INFO - Downloaded 54978743 bytes. 05:00:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:00:13 INFO - mkdir: /builds/slave/test-pgo/properties 05:00:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:00:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:00:13 INFO - Contents: 05:00:13 INFO - build_url:https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:00:13 INFO - Running post-action listener: _resource_record_post_action 05:00:13 INFO - Running post-action listener: set_extra_try_arguments 05:00:13 INFO - ##### 05:00:13 INFO - ##### Running populate-webroot step. 05:00:13 INFO - ##### 05:00:13 INFO - Running pre-action listener: _resource_record_pre_action 05:00:13 INFO - Running main action method: populate_webroot 05:00:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:13 INFO - '--tppagecycles', 05:00:13 INFO - '7'], 05:00:13 INFO - 'tests': ['tsvgm']}}, 05:00:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:00:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:00:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:00:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'tests': ['damp', 'tps']}, 05:00:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['damp', 'tps']}, 05:00:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:00:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:13 INFO - 'other': {'tests': ['a11yr', 05:00:13 INFO - 'ts_paint', 05:00:13 INFO - 'tpaint', 05:00:13 INFO - 'sessionrestore', 05:00:13 INFO - 'sessionrestore_no_auto_restore']}, 05:00:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['a11yr', 05:00:13 INFO - 'ts_paint', 05:00:13 INFO - 'tpaint', 05:00:13 INFO - 'sessionrestore', 05:00:13 INFO - 'sessionrestore_no_auto_restore']}, 05:00:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['a11yr', 05:00:13 INFO - 'ts_paint', 05:00:13 INFO - 'tpaint', 05:00:13 INFO - 'sessionrestore', 05:00:13 INFO - 'sessionrestore_no_auto_restore']}, 05:00:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['a11yr', 05:00:13 INFO - 'ts_paint', 05:00:13 INFO - 'tpaint', 05:00:13 INFO - 'sessionrestore', 05:00:13 INFO - 'sessionrestore_no_auto_restore']}, 05:00:13 INFO - 'other_l64': {'tests': ['a11yr', 05:00:13 INFO - 'ts_paint', 05:00:13 INFO - 'tpaint', 05:00:13 INFO - 'sessionrestore', 05:00:13 INFO - 'sessionrestore_no_auto_restore']}, 05:00:13 INFO - 'other_nol64': {'tests': ['a11yr', 05:00:13 INFO - 'ts_paint', 05:00:13 INFO - 'tpaint', 05:00:13 INFO - 'sessionrestore', 05:00:13 INFO - 'sessionrestore_no_auto_restore']}, 05:00:13 INFO - 'svgr': {'tests': ['tsvgx', 05:00:13 INFO - 'tsvgr_opacity', 05:00:13 INFO - 'tart', 05:00:13 INFO - 'tscrollx', 05:00:13 INFO - 'cart']}, 05:00:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['tsvgx', 05:00:13 INFO - 'tsvgr_opacity', 05:00:13 INFO - 'tart', 05:00:13 INFO - 'tscrollx', 05:00:13 INFO - 'cart']}, 05:00:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'tests': ['tp5o']}, 05:00:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'talos_options': ['--e10s'], 05:00:13 INFO - 'tests': ['tp5o']}, 05:00:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'talos_options': ['--xperf_path', 05:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:13 INFO - 'tests': ['tp5n']}, 05:00:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:13 INFO - 'talos_options': ['--e10s', 05:00:13 INFO - '--xperf_path', 05:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:13 INFO - 'tests': ['tp5n']}}, 05:00:13 INFO - 'talos.zip': {'path': '', 05:00:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:13 INFO - Running post-action listener: _resource_record_post_action 05:00:13 INFO - ##### 05:00:13 INFO - ##### Running create-virtualenv step. 05:00:13 INFO - ##### 05:00:13 INFO - Running pre-action listener: _resource_record_pre_action 05:00:13 INFO - Running main action method: create_virtualenv 05:00:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:00:13 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 05:00:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:00:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:13 INFO - Using real prefix '/usr' 05:00:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:00:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:16 INFO - Installing pip.................done. 05:00:16 INFO - Return code: 0 05:00:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:00:16 INFO - Using env: {'DISPLAY': ':0', 05:00:16 INFO - 'HOME': '/home/cltbld', 05:00:16 INFO - 'LANG': 'en_US.UTF-8', 05:00:16 INFO - 'LANGUAGE': 'en_US:en', 05:00:16 INFO - 'LOGNAME': 'cltbld', 05:00:16 INFO - 'MAIL': '/var/mail/cltbld', 05:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:16 INFO - 'MOZ_NO_REMOTE': '1', 05:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:16 INFO - 'NO_EM_RESTART': '1', 05:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:16 INFO - 'SHELL': '/bin/bash', 05:00:16 INFO - 'SHLVL': '1', 05:00:16 INFO - 'TERM': 'linux', 05:00:16 INFO - 'TMOUT': '86400', 05:00:16 INFO - 'USER': 'cltbld', 05:00:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:16 INFO - '_': '/tools/buildbot/bin/python'} 05:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:16 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 05:00:16 INFO - Cleaning up... 05:00:16 INFO - Return code: 0 05:00:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:00:16 INFO - Using env: {'DISPLAY': ':0', 05:00:16 INFO - 'HOME': '/home/cltbld', 05:00:16 INFO - 'LANG': 'en_US.UTF-8', 05:00:16 INFO - 'LANGUAGE': 'en_US:en', 05:00:16 INFO - 'LOGNAME': 'cltbld', 05:00:16 INFO - 'MAIL': '/var/mail/cltbld', 05:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:16 INFO - 'MOZ_NO_REMOTE': '1', 05:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:16 INFO - 'NO_EM_RESTART': '1', 05:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:16 INFO - 'SHELL': '/bin/bash', 05:00:16 INFO - 'SHLVL': '1', 05:00:16 INFO - 'TERM': 'linux', 05:00:16 INFO - 'TMOUT': '86400', 05:00:16 INFO - 'USER': 'cltbld', 05:00:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:16 INFO - '_': '/tools/buildbot/bin/python'} 05:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:16 INFO - Downloading/unpacking psutil>=0.7.1 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:18 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:00:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:00:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:18 INFO - Installing collected packages: psutil 05:00:18 INFO - Running setup.py install for psutil 05:00:18 INFO - building 'psutil._psutil_linux' extension 05:00:18 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 05:00:18 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 05:00:18 INFO - building 'psutil._psutil_posix' extension 05:00:18 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 05:00:18 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 05:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:18 INFO - Successfully installed psutil 05:00:18 INFO - Cleaning up... 05:00:18 INFO - Return code: 0 05:00:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:00:18 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')]} 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:18 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')]} 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:18 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:18 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 05:00:18 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 05:00:18 INFO - Using env: {'DISPLAY': ':0', 05:00:18 INFO - 'HOME': '/home/cltbld', 05:00:18 INFO - 'LANG': 'en_US.UTF-8', 05:00:18 INFO - 'LANGUAGE': 'en_US:en', 05:00:18 INFO - 'LOGNAME': 'cltbld', 05:00:18 INFO - 'MAIL': '/var/mail/cltbld', 05:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:18 INFO - 'MOZ_NO_REMOTE': '1', 05:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:18 INFO - 'NO_EM_RESTART': '1', 05:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:18 INFO - 'SHELL': '/bin/bash', 05:00:18 INFO - 'SHLVL': '1', 05:00:18 INFO - 'TERM': 'linux', 05:00:18 INFO - 'TMOUT': '86400', 05:00:18 INFO - 'USER': 'cltbld', 05:00:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:18 INFO - '_': '/tools/buildbot/bin/python'} 05:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:00:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:00:20 INFO - Installing collected packages: mozsystemmonitor 05:00:20 INFO - Running setup.py install for mozsystemmonitor 05:00:20 INFO - Successfully installed mozsystemmonitor 05:00:20 INFO - Cleaning up... 05:00:20 INFO - Return code: 0 05:00:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:20 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:20 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 05:00:20 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 05:00:20 INFO - Using env: {'DISPLAY': ':0', 05:00:20 INFO - 'HOME': '/home/cltbld', 05:00:20 INFO - 'LANG': 'en_US.UTF-8', 05:00:20 INFO - 'LANGUAGE': 'en_US:en', 05:00:20 INFO - 'LOGNAME': 'cltbld', 05:00:20 INFO - 'MAIL': '/var/mail/cltbld', 05:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:20 INFO - 'MOZ_NO_REMOTE': '1', 05:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:20 INFO - 'NO_EM_RESTART': '1', 05:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:20 INFO - 'SHELL': '/bin/bash', 05:00:20 INFO - 'SHLVL': '1', 05:00:20 INFO - 'TERM': 'linux', 05:00:20 INFO - 'TMOUT': '86400', 05:00:20 INFO - 'USER': 'cltbld', 05:00:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:20 INFO - '_': '/tools/buildbot/bin/python'} 05:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:21 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 05:00:21 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 05:00:21 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 05:00:21 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 05:00:21 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 05:00:21 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 05:00:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:00:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:22 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 05:00:22 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 05:00:22 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 05:00:22 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 05:00:22 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 05:00:22 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 05:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:00:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:23 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 05:00:23 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 05:00:23 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 05:00:23 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 05:00:23 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 05:00:23 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 05:00:23 INFO - Downloading docopt-0.6.1.tar.gz 05:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:23 INFO - Running setup.py install for blobuploader 05:00:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:00:23 INFO - Running setup.py install for requests 05:00:23 INFO - Running setup.py install for docopt 05:00:24 INFO - Successfully installed blobuploader requests docopt 05:00:24 INFO - Cleaning up... 05:00:24 INFO - Return code: 0 05:00:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:24 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:24 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 05:00:24 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 05:00:24 INFO - Using env: {'DISPLAY': ':0', 05:00:24 INFO - 'HOME': '/home/cltbld', 05:00:24 INFO - 'LANG': 'en_US.UTF-8', 05:00:24 INFO - 'LANGUAGE': 'en_US:en', 05:00:24 INFO - 'LOGNAME': 'cltbld', 05:00:24 INFO - 'MAIL': '/var/mail/cltbld', 05:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:24 INFO - 'MOZ_NO_REMOTE': '1', 05:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:24 INFO - 'NO_EM_RESTART': '1', 05:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:24 INFO - 'SHELL': '/bin/bash', 05:00:24 INFO - 'SHLVL': '1', 05:00:24 INFO - 'TERM': 'linux', 05:00:24 INFO - 'TMOUT': '86400', 05:00:24 INFO - 'USER': 'cltbld', 05:00:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:24 INFO - '_': '/tools/buildbot/bin/python'} 05:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:24 INFO - Running setup.py (path:/tmp/pip-IhhdfY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:24 INFO - Running setup.py (path:/tmp/pip-Y06Ee7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:24 INFO - Running setup.py (path:/tmp/pip-wiWHtW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:24 INFO - Running setup.py (path:/tmp/pip-7A3H6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:24 INFO - Running setup.py (path:/tmp/pip-1SYY5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:24 INFO - Running setup.py (path:/tmp/pip-wKKWct-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:24 INFO - Running setup.py (path:/tmp/pip-Q7KxEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:24 INFO - Running setup.py (path:/tmp/pip-7S3aFl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:24 INFO - Running setup.py (path:/tmp/pip-P7pOs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:24 INFO - Running setup.py (path:/tmp/pip-NZWAal-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:25 INFO - Running setup.py (path:/tmp/pip-FAwEDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:25 INFO - Running setup.py (path:/tmp/pip-vFpNUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:25 INFO - Running setup.py (path:/tmp/pip-VrdGCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:25 INFO - Running setup.py (path:/tmp/pip-cuxoFp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:25 INFO - Running setup.py (path:/tmp/pip-G3TEJ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:25 INFO - Running setup.py (path:/tmp/pip-iiyazf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:25 INFO - Running setup.py (path:/tmp/pip-XySGWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:25 INFO - Running setup.py install for manifestparser 05:00:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:00:25 INFO - Running setup.py install for mozcrash 05:00:25 INFO - Running setup.py install for mozdebug 05:00:25 INFO - Running setup.py install for mozdevice 05:00:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:00:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:00:25 INFO - Running setup.py install for mozfile 05:00:26 INFO - Running setup.py install for mozhttpd 05:00:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for mozinfo 05:00:26 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for mozInstall 05:00:26 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for mozleak 05:00:26 INFO - Running setup.py install for mozlog 05:00:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for moznetwork 05:00:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for mozprocess 05:00:26 INFO - Running setup.py install for mozprofile 05:00:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for mozrunner 05:00:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:00:26 INFO - Running setup.py install for mozscreenshot 05:00:27 INFO - Running setup.py install for moztest 05:00:27 INFO - Running setup.py install for mozversion 05:00:27 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:00:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:27 INFO - Cleaning up... 05:00:27 INFO - Return code: 0 05:00:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:27 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')]} 05:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:27 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')]} 05:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:27 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:27 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 05:00:27 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 05:00:27 INFO - Using env: {'DISPLAY': ':0', 05:00:27 INFO - 'HOME': '/home/cltbld', 05:00:27 INFO - 'LANG': 'en_US.UTF-8', 05:00:27 INFO - 'LANGUAGE': 'en_US:en', 05:00:27 INFO - 'LOGNAME': 'cltbld', 05:00:27 INFO - 'MAIL': '/var/mail/cltbld', 05:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:27 INFO - 'MOZ_NO_REMOTE': '1', 05:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:27 INFO - 'NO_EM_RESTART': '1', 05:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:27 INFO - 'SHELL': '/bin/bash', 05:00:27 INFO - 'SHLVL': '1', 05:00:27 INFO - 'TERM': 'linux', 05:00:27 INFO - 'TMOUT': '86400', 05:00:27 INFO - 'USER': 'cltbld', 05:00:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:27 INFO - '_': '/tools/buildbot/bin/python'} 05:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:27 INFO - Running setup.py (path:/tmp/pip-ZFTjvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:27 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)) 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:27 INFO - Running setup.py (path:/tmp/pip-rvuaO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:27 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)) 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:27 INFO - Running setup.py (path:/tmp/pip-fG5um8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:27 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)) 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:27 INFO - Running setup.py (path:/tmp/pip-m4dOUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:27 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)) 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:27 INFO - Running setup.py (path:/tmp/pip-xUYR3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:27 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)) 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:27 INFO - Running setup.py (path:/tmp/pip-czPgSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:27 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)) 05:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:27 INFO - Running setup.py (path:/tmp/pip-yr2XR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:28 INFO - Running setup.py (path:/tmp/pip-Y0f5Ud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:28 INFO - Running setup.py (path:/tmp/pip-dsM2kE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:28 INFO - Running setup.py (path:/tmp/pip-4uC6Ph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:28 INFO - Running setup.py (path:/tmp/pip-rdfU8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:28 INFO - Running setup.py (path:/tmp/pip-hh2GJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:28 INFO - Running setup.py (path:/tmp/pip-eVd1ed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:28 INFO - Running setup.py (path:/tmp/pip-5EXOuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:28 INFO - Running setup.py (path:/tmp/pip-_dW8aF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:28 INFO - Running setup.py (path:/tmp/pip-neLOuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:28 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)) 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:28 INFO - Running setup.py (path:/tmp/pip-2Nl5Eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:28 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)) 05:00:28 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)) 05:00:28 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)) 05:00:28 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)) 05:00:28 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)) 05:00:28 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)) 05:00:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:30 INFO - Downloading blessings-1.5.1.tar.gz 05:00:30 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 05:00:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:30 INFO - Installing collected packages: blessings 05:00:30 INFO - Running setup.py install for blessings 05:00:30 INFO - Successfully installed blessings 05:00:30 INFO - Cleaning up... 05:00:30 INFO - Return code: 0 05:00:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:00:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:30 INFO - Reading from file tmpfile_stdout 05:00:30 INFO - Current package versions: 05:00:30 INFO - argparse == 1.2.1 05:00:30 INFO - blessings == 1.5.1 05:00:30 INFO - blobuploader == 1.2.4 05:00:30 INFO - docopt == 0.6.1 05:00:30 INFO - manifestparser == 1.1 05:00:30 INFO - mozInstall == 1.12 05:00:30 INFO - mozcrash == 0.16 05:00:30 INFO - mozdebug == 0.1 05:00:30 INFO - mozdevice == 0.47 05:00:30 INFO - mozfile == 1.2 05:00:30 INFO - mozhttpd == 0.7 05:00:30 INFO - mozinfo == 0.9 05:00:30 INFO - mozleak == 0.1 05:00:30 INFO - mozlog == 3.1 05:00:30 INFO - moznetwork == 0.27 05:00:30 INFO - mozprocess == 0.22 05:00:30 INFO - mozprofile == 0.28 05:00:30 INFO - mozrunner == 6.11 05:00:30 INFO - mozscreenshot == 0.1 05:00:30 INFO - mozsystemmonitor == 0.0 05:00:30 INFO - moztest == 0.7 05:00:30 INFO - mozversion == 1.4 05:00:30 INFO - psutil == 3.1.1 05:00:30 INFO - requests == 1.2.3 05:00:30 INFO - wsgiref == 0.1.2 05:00:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:30 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:30 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 05:00:30 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 05:00:30 INFO - Using env: {'DISPLAY': ':0', 05:00:30 INFO - 'HOME': '/home/cltbld', 05:00:30 INFO - 'LANG': 'en_US.UTF-8', 05:00:30 INFO - 'LANGUAGE': 'en_US:en', 05:00:30 INFO - 'LOGNAME': 'cltbld', 05:00:30 INFO - 'MAIL': '/var/mail/cltbld', 05:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:30 INFO - 'MOZ_NO_REMOTE': '1', 05:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:30 INFO - 'NO_EM_RESTART': '1', 05:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:30 INFO - 'SHELL': '/bin/bash', 05:00:30 INFO - 'SHLVL': '1', 05:00:30 INFO - 'TERM': 'linux', 05:00:30 INFO - 'TMOUT': '86400', 05:00:30 INFO - 'USER': 'cltbld', 05:00:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:30 INFO - '_': '/tools/buildbot/bin/python'} 05:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 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)) 05:00:31 INFO - Cleaning up... 05:00:31 INFO - Return code: 0 05:00:31 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:00:31 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')]} 05:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:31 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')]} 05:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:31 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:31 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 05:00:31 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 05:00:31 INFO - Using env: {'DISPLAY': ':0', 05:00:31 INFO - 'HOME': '/home/cltbld', 05:00:31 INFO - 'LANG': 'en_US.UTF-8', 05:00:31 INFO - 'LANGUAGE': 'en_US:en', 05:00:31 INFO - 'LOGNAME': 'cltbld', 05:00:31 INFO - 'MAIL': '/var/mail/cltbld', 05:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:31 INFO - 'MOZ_NO_REMOTE': '1', 05:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:31 INFO - 'NO_EM_RESTART': '1', 05:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:31 INFO - 'SHELL': '/bin/bash', 05:00:31 INFO - 'SHLVL': '1', 05:00:31 INFO - 'TERM': 'linux', 05:00:31 INFO - 'TMOUT': '86400', 05:00:31 INFO - 'USER': 'cltbld', 05:00:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:31 INFO - '_': '/tools/buildbot/bin/python'} 05:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:31 INFO - Downloading/unpacking jsonschema 05:00:31 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 05:00:31 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 05:00:31 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 05:00:31 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 05:00:31 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 05:00:31 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 05:00:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:32 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 05:00:33 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:33 INFO - warning: no files found matching '*.txt' 05:00:33 INFO - no previously-included directories found matching 'build' 05:00:33 INFO - no previously-included directories found matching 'dist' 05:00:33 INFO - no previously-included directories found matching '.git*' 05:00:33 INFO - Installing collected packages: jsonschema, functools32 05:00:33 INFO - Running setup.py install for functools32 05:00:33 INFO - warning: no files found matching '*.txt' 05:00:33 INFO - no previously-included directories found matching 'build' 05:00:33 INFO - no previously-included directories found matching 'dist' 05:00:33 INFO - no previously-included directories found matching '.git*' 05:00:33 INFO - Successfully installed jsonschema functools32 05:00:33 INFO - Cleaning up... 05:00:33 INFO - Return code: 0 05:00:33 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:33 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 0x7f96a7e0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2135630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', '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 05:00:33 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 05:00:33 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 05:00:33 INFO - Using env: {'DISPLAY': ':0', 05:00:33 INFO - 'HOME': '/home/cltbld', 05:00:33 INFO - 'LANG': 'en_US.UTF-8', 05:00:33 INFO - 'LANGUAGE': 'en_US:en', 05:00:33 INFO - 'LOGNAME': 'cltbld', 05:00:33 INFO - 'MAIL': '/var/mail/cltbld', 05:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:33 INFO - 'MOZ_NO_REMOTE': '1', 05:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:33 INFO - 'NO_EM_RESTART': '1', 05:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:33 INFO - 'SHELL': '/bin/bash', 05:00:33 INFO - 'SHLVL': '1', 05:00:33 INFO - 'TERM': 'linux', 05:00:33 INFO - 'TMOUT': '86400', 05:00:33 INFO - 'USER': 'cltbld', 05:00:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:33 INFO - '_': '/tools/buildbot/bin/python'} 05:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:33 INFO - Downloading/unpacking flake8 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 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 05:00:33 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 05:00:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:35 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 05:00:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:35 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 05:00:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:35 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 05:00:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:00:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:35 INFO - no previously-included directories found matching 'docs/_build' 05:00:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:36 INFO - Running setup.py install for pep8 05:00:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:36 INFO - no previously-included directories found matching 'docs/_build' 05:00:36 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:00:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:36 INFO - Cleaning up... 05:00:37 INFO - Return code: 0 05:00:37 INFO - Running post-action listener: _resource_record_post_action 05:00:37 INFO - Running post-action listener: _start_resource_monitoring 05:00:37 INFO - Starting resource monitoring. 05:00:37 INFO - ##### 05:00:37 INFO - ##### Running install step. 05:00:37 INFO - ##### 05:00:37 INFO - Running pre-action listener: _resource_record_pre_action 05:00:37 INFO - Running main action method: install 05:00:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:37 INFO - Reading from file tmpfile_stdout 05:00:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:00:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:00:37 INFO - Reading from file tmpfile_stdout 05:00:37 INFO - Output received: 05:00:37 INFO - Usage: mozinstall [options] installer 05:00:37 INFO - Options: 05:00:37 INFO - -h, --help show this help message and exit 05:00:37 INFO - -d DEST, --destination=DEST 05:00:37 INFO - Directory to install application into. [default: 05:00:37 INFO - "/builds/slave/test-pgo"] 05:00:37 INFO - --app=APP Application being installed. [default: firefox] 05:00:37 INFO - mkdir: /builds/slave/test-pgo/build/application 05:00:37 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'] 05:00:37 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 05:00:53 INFO - Reading from file tmpfile_stdout 05:00:53 INFO - Output received: 05:00:53 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:00:53 INFO - Running post-action listener: _resource_record_post_action 05:00:53 INFO - ##### 05:00:53 INFO - ##### Running run-tests step. 05:00:53 INFO - ##### 05:00:53 INFO - Running pre-action listener: _resource_record_pre_action 05:00:53 INFO - Running main action method: run_tests 05:00:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:00:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:00:53 INFO - Python 2.7.3 05:00:53 INFO - Return code: 0 05:00:53 INFO - grabbing minidump binary from tooltool 05:00: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')]} 05:00:53 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 0x21c6840>, '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 0x21336b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2133b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:00:53 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 05:00:53 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 05:00:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:53 INFO - Return code: 0 05:00:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:00:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:00:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:00:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:00:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:00:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:00:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:00:54 INFO - Return code: 0 05:00:54 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:00:54 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:00:54 INFO - Using env: {'DISPLAY': ':0', 05:00:54 INFO - 'HOME': '/home/cltbld', 05:00:54 INFO - 'LANG': 'en_US.UTF-8', 05:00:54 INFO - 'LANGUAGE': 'en_US:en', 05:00:54 INFO - 'LOGNAME': 'cltbld', 05:00:54 INFO - 'MAIL': '/var/mail/cltbld', 05:00:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:00:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:54 INFO - 'MOZ_NO_REMOTE': '1', 05:00:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:54 INFO - 'NO_EM_RESTART': '1', 05:00:54 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:54 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:00:54 INFO - 'SHELL': '/bin/bash', 05:00:54 INFO - 'SHLVL': '1', 05:00:54 INFO - 'TERM': 'linux', 05:00:54 INFO - 'TMOUT': '86400', 05:00:54 INFO - 'USER': 'cltbld', 05:00:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565', 05:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:54 INFO - '_': '/tools/buildbot/bin/python'} 05:00:54 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:00:54 INFO - mozversion application_buildid: 20160105023037 05:00:54 INFO - mozversion application_changeset: 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 05:00:54 INFO - mozversion application_display_name: Nightly 05:00:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:54 INFO - mozversion application_name: Firefox 05:00:54 INFO - mozversion application_remotingname: firefox 05:00:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:00:54 INFO - mozversion application_vendor: Mozilla 05:00:54 INFO - mozversion application_version: 46.0a1 05:00:54 INFO - mozversion platform_buildid: 20160105023037 05:00:54 INFO - mozversion platform_changeset: 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 05:00:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:00:54 INFO - mozversion platform_version: 46.0a1 05:00:54 INFO - using testdate: 1451998854 05:00:54 INFO - actual date: 1451998854 05:00:54 INFO - starting webserver on 'localhost:38424' 05:00:54 INFO - SUITE-START | Running 3 tests 05:00:54 INFO - TEST-START | dromaeo_css 05:00:54 INFO - operating with platform_type : linux_ 05:00:54 INFO - Initialising browser for dromaeo_css test... 05:00:54 INFO - TEST-INFO | started process 28809 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqlfmrN/profile http://localhost:38424/getInfo.html) 05:00:58 INFO - PROCESS | 28809 | __metrics Screen width/height:1600/1200 05:00:58 INFO - PROCESS | 28809 | colorDepth:24 05:00:58 INFO - PROCESS | 28809 | Browser inner width/height: 1024/697 05:00:58 INFO - PROCESS | 28809 | __metrics 05:00:58 INFO - PROCESS | 28809 | 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:00:58 INFO - PROCESS | 28809 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:00:59 INFO - TEST-INFO | 28809: exit 0 05:00:59 INFO - Browser initialized. 05:00:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:59 INFO - TEST-INFO | started process 28902 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqlfmrN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:11 INFO - PROCESS | 28902 | RSS: Main: 149995520 05:01:11 INFO - PROCESS | 28902 | 05:02:02 INFO - PROCESS | 28902 | 1451998922006 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] 05:04:11 INFO - PROCESS | 28902 | Cycle 1(1): loaded http://localhost:38424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38424/tests/dromaeo/cssquery-ext.html) 05:04:12 INFO - PROCESS | 28902 | RSS: Main: 256950272 05:04:12 INFO - PROCESS | 28902 | 05:07:14 INFO - PROCESS | 28902 | Cycle 1(1): loaded http://localhost:38424/tests/dromaeo/cssquery-ext.html (next: http://localhost:38424/tests/dromaeo/cssquery-jquery.html) 05:07:15 INFO - PROCESS | 28902 | RSS: Main: 232148992 05:07:15 INFO - PROCESS | 28902 | 05:10:17 INFO - PROCESS | 28902 | Cycle 1(1): loaded http://localhost:38424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38424/tests/dromaeo/cssquery-mootools.html) 05:10:18 INFO - PROCESS | 28902 | RSS: Main: 228900864 05:10:18 INFO - PROCESS | 28902 | 05:13:19 INFO - PROCESS | 28902 | Cycle 1(1): loaded http://localhost:38424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38424/tests/dromaeo/cssquery-prototype.html) 05:13:20 INFO - PROCESS | 28902 | RSS: Main: 210014208 05:13:20 INFO - PROCESS | 28902 | 05:16:22 INFO - PROCESS | 28902 | Cycle 1(1): loaded http://localhost:38424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38424/tests/dromaeo/cssquery-yui.html) 05:16:23 INFO - PROCESS | 28902 | RSS: Main: 216731648 05:16:23 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | Cycle 1(1): loaded http://localhost:38424/tests/dromaeo/cssquery-yui.html (next: http://localhost:38424/tests/dromaeo/cssquery-dojo.html) 05:19:26 INFO - PROCESS | 28902 | RSS: Main: 304226304 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | __start_tp_report 05:19:26 INFO - PROCESS | 28902 | _x_x_mozilla_page_load 05:19:26 INFO - PROCESS | 28902 | _x_x_mozilla_page_load_details 05:19:26 INFO - PROCESS | 28902 | |i|pagename|runs| 05:19:26 INFO - PROCESS | 28902 | |0;dojo.html;3165.256164801271;3221.4362486564846;3267.05255475912;3269.084656296238;3300.917477063073;5149.974250128744;5276.498732620405;5281.234221037952;5300.6819590824525;5378.031954248228;5236.895262094766;5339.385970613371;5409.6213265071465;5413.918791218135;5426.8371948841495;4841.394825646794;4844.733539655326;4863.732494712789;4866.294387313855;4913.705177689332;4723.551262630044;4944.283078953567;4969.577585905203;4972.900541989158;5022.321986531826;4759.595434388081;4822.397200349974;4876.487968763265;4882.6826256293225;4892.3884514435695;4821.228603423436;4832.7825247863575;4853.95146048542;4859.028194361142;4891.413030436335;4685.976570117127;4853.102176097398;4854.320395144682;4856.732879691615;4905.3132561441425;5053.444121146671;5134.101532231882;5229.555487783543;5257.737113144328;5269.762860671241;5728.68492232927;5740.684262365568;5741.081426971665;5745.597808153431;5747.109198074263;5524.751386187631;5665.3768085510565;5766.163906233573;5776.913346299809;5779.508741756956;5260.894782104375;5284.339457567804;5395.163749618815;5413.377461591967;5455.18172274162;5864.354920958691;5865.149553314831;5869;5876.647401155944;5904.5571582131515;5632.831015069554;5636.887262254732;5638.43615638441;5641.80253691127;5645.745941432645;5446.645968012067;5640.520555752725;5677.716114194356;5733.3406658234;5845.386234445407;5669.886602267931;5679.8864022720145;5683.346415162227;5683.573731970118;5684.8010319638615;5425.755840987165;5613.803516876889;5618.269624948813;5649.4633009864;5663.348714897839;4305.268104422255;4321.438213032286;4332.155229730235;4436.068425630654;4441.378207051015;3883.456316115746;3915.1778126593163;3915.197384536163;3930.76415415076;3948.072203032285;5281.15501519755;5285.445028272053;5288.391834938954;5291.788328466895;5297.258383826267;5522.447755224445;5597.63615365;5621.409751976065;5633.014222511044;5738.540916726652;5337;5340.679559226459;5341;5367.221752845816;5377.78488860449;4880.731559764176;4883.609311255091;4897.926531102036;4900.14247506692;4932;5694.743736531866;5819.330776960704;5826.096954971986;5925.34821169671;5928.584999050025;5624.465675760796;5714.971425143014;5716.714164291686;5728.570357223141;5773.134029895549;5893.174955506318;5919.911201331897;5929.555283353679;5938.287405511366;5938.762449501972;5437.157240627709;5555.944440555542;5562.471565201299;5700.885982280414;5735.942640573541;5552.5557955362665;5564.749586268546;5630.352509461464;5776.19133321327;5807.94192058074;5637.605367624227;5651.15232715096;5656.349519805275;5662.377138514677;5664.122061080539;5633.2395126657375;5641.971790141023;5650.85872853182;5651.095824668033;5655.377908430151;5323.467653234646;5396.757145928521;5453.072977593739;5456.236126942152;5591.916121258266;5627.18405831144;5660.433956604471;5663.716814159358;5668.178114173505;5710.771569137188;5460.672359658433;5523.033469142803;5524.392316845224;5530.170474428707;5531.585131115263 05:19:26 INFO - PROCESS | 28902 | |1;ext.html;513.5968264912043;524.9265102885596;529.4255732530205;549.8103154411727;588.8881112588605;27949.860250698744;28450.857745711295;28483.287917802067;28486.011958325824;34595.65404345956;37792.622073779254;38038;38181.42727859085;38266.61733382665;38297.80851095741;8365.665373385058;8499.36254780894;8525.701600443987;8528.488290702579;8531.104234055429;7326.340629343358;7489.28851759082;8290.253877151055;9816.214702823758;10099;9694;9907.455089970048;9951;9977.75055623608;9983.151432128278;7568.508046976929;9804.607815687365;9918.950405247928;9920.702378928643;9932.6523571675;7383.114026316823;9846.90153098467;10016.799664006752;10097.343672661253;10106.140978016878;35262.823685881405;35659.10852228689;35877.46183807219;35879.82060089709;36003.63996360029;3151.8739250429953;3160.7787454878166;3205.5832741743657;3297.7032067113837;3361.445361515347;27630.72369276322;28231.294217644518;28681.890052589446;28799.424011519863;29713.25716857096;3921.686265098785;3937.6652984496354;3972.5828787977134;4049.5545489996075;4051.4327994080854;268252;268277;268680;269428;269525;50022.499775002514;50887.74556127196;55821.441785582436;56178;57205;51188;51230.48769512332;51388;51390;51433;14236.28818559068;14297.642558935902;14307.213103279211;14309.92675549338;14323.57029289123;11504.367259800623;11570.537178512934;11584.94207528957;11597.13021523389;11721.706957325965;18588.721169182474;18672.906635466737;18739.531511712044;18787;18827.34104306343;7205.279472052753;7347.88978165328;7414.332710056121;7420.814479637944;7493.625318734151;931.4550987672287;951.8714973478492;983.8229118758692;988.3081842710131;999.4303247149055;27310.317242069108;27473.587896181572;27972.44055118886;28005.859970700018;28157.43685126286;998.0119681515248;1047.643801107627;1058.1270451877078;1067.1356201476829;1082.5345101606226;13540.187588744708;14867.256637168315;15087.858631986455;15495.690086198212;15809.209539522977;313340;317412;318408;318643;318922;50492.74753626208;50730.746346268774;50751;50767.74616126896;50826.49173508291;1317.1636011133;1317.1965101288206;1323.3846261488454;1335.0787956310114;1338.491373278148;23560;26552.601710974737;27002.594961075993;27750.583741243492;28068.578971315037;40436.59563404328;40574.39138412985;40854.59145408508;40872.59127408688;40889.38665920073;231759;233705;234197;234527;277114;24790.876045620378;29982.80240766338;30078.24804379908;30362.39275214439;30476.390472190877;37153.81423092867;38173.61826381812;38378.61621383862;38417.80791096027;38796.80601596974;32379.838100810288;32589.18527036843;32735;32788.83605581957;33228.169295766835;33117.83441082779;33222.83388583042;33260;33336;33606;34567.65432345745;34747;34761;35337.469937951464;35592.22038897993;26503.33741656397;26601.866990664923;29043.419131616825;29546.409071818875;29727.851360743058;22867.771322286564;23009.309720708407;24093.879530602233;24440.75559244385;24555.877220613784 05:19:26 INFO - PROCESS | 28902 | |2;jquery.html;354.29848899179626;355.6976569915572;358.02973940620916;358.739913562667;359.6619177972705;13999.440022399118;14378.281085945688;16200.351985920564;16351.100689462075;17194.570135746613;15761.842381576182;16047.037177769342;16052.277647505862;16063.437779677713;16073.598160046005;4613.1696294666945;4869.707817530942;4870.099031679133;4873.293372460991;4873.293372461008;3776.4901738265394;3891.3190191716476;4801.61587073035;5106.821261255838;6066.787662431816;6001.309849367335;6025.517958563304;6043.546733994946;6043.879122417549;6048.334683184846;5855.414458554132;6016.608920420159;6019.036954087369;6029.517638588903;6032.819015429544;5216.843494695166;5316.73416329182;5331.067063263913;5351.197320401932;5353.518183363477;18927.716084258747;19004.42986710401;19407.320743774042;19681.803181968142;19737.309194178277;1968.5570746582048;2075.6056349293585;2089.634313995045;2155.948959992854;2186.1146235774536;8991.775205619846;9667.564959576835;10354.53404596795;10382.273240873143;13204.339783010812;1781.750554922312;1811.8641101917408;1813.6010077782867;1912.4549503391468;1933.3040105562127;54233;55814.44185558133;58448.41551584515;60833;61206.69396653033;9462;9769.16962058233;9990.650327238513;10005.449700266556;10033.247506437046;12795.744085118245;12808.80786788199;12820.166689165175;12827.358632068359;12835.614931552069;7003.124609423822;7053.294670532906;7248.202697703248;7288.380487658608;7328.926710732824;6710.698018589175;6792.388685018372;6807.897881531781;6842.623655698984;6866.622335771581;4359.520452750195;4367.432233809584;4420.160169567772;4428.158649856517;4497.527759585262;1688.8480036796748;1756.262369804685;1760.392664530735;1788.8926664399917;1796.4161647464625;923.1783712495884;924.5654542365078;958.4393130018877;958.5878072428783;983.9458829764432;16271.430499932445;16825.495235142964;17071.973584400595;17263.223154958057;17276.13619319029;849.6516428264382;893.0489029184029;898.8786513820681;900.5317235037744;982.8230918434607;8628.654853805778;9125.863112053325;9393;9889.307748457539;9985.650502232387;117914.41042794903;118871;119034.4048279753;119144;119306;75888.24111758811;76744.61627691826;78790;78867.60566197132;80328.59835700784;1146.931184128955;1148.1847887999447;1210.5339444314002;1212.2241765270235;1238.3931873382157;15219.543413697163;15238.847611523743;15601.84398156004;15698.607534811721;16006.839931600534;35662.64337356593;35687;35872.28255434825;36632.45051324285;36678.08304792402;26966.730332697207;38214;44336.33495497506;45024.14686090787;47214.52785472101;14663.266836657911;14747.55757327282;14752.55742327732;15135.697286053997;15156;14215.573532794033;18496.72254916204;18844.717329240346;18916.621667566847;19433.805661943767;12064.457099430721;14043.648908777363;14278.428862845785;14878.10731356122;14975;14144.78782818238;14828.332725027183;15045.548633541011;15116.168610726516;15338.693226135638;11671.416429178676;12771.106022578702;14204.502842400467;14895.627609309853;15661.451849185223;13574.185548867099;13638.727225455634;13739.793903091262;13796.448142074205;13876.791848122488;13711.862881371457;14171;14297.857021429652;14432.061915975848;14838.629034274229 05:19:26 INFO - PROCESS | 28902 | |3;mootools.html;1254.887060164585;1433.7992681024655;1434.0965191929083;1556.4785796758085;1734.6010417603943;6548.934510654892;7161.104861892263;7262.310080542353;7281.453890958172;7285;7368.2263362346985;7584.241575842413;7587.393008559316;7589.392848572114;7592.088949326075;2220.311703371952;2240.204727321802;2243.5288589396246;2245.5621153875;2249.910003599854;2171.554831259596;2234.6089434349005;2237.3064350051454;2238.6418173092306;2245.9663105053437;2187.726534183227;2224.5995720770256;2225.7440394354694;2262.751097379287;2263.366257447909;2203.372038968886;2222.9333120006345;2252.8986195621237;2255.6616507523922;2256.379495638696;2202.0751284460407;2229.5317983223545;2237.7202849643795;2238.3620668109675;2240.215924426454;7349.7060117595765;7435.591042492661;7452.664630091659;7461.925380746177;7501.962490187569;4364.694471387004;4418.690691651585;4453.53237910018;4455.309427038814;4456.598906098434;2878.7984841061134;2979.0764862892356;2984.0749367696085;2998.5502174673757;3015.200971742468;1022.8056669232822;1031.6750223679517;1034.7775228325945;1057.154276578734;1065.1053115383038;9780;9780.168685661727;9790.069943355442;9794.412335259836;9799.755006124762;3941.2905676977844;3990.20195960809;4005.559388467266;4033.1127152026506;4047.170330082326;8580.442271252348;8755.430896991802;8766.912330876738;8772.736817895473;8784.692535761218;4429.11417716458;4440.489343725449;4469.486009108994;4471.485779135441;4476.820927162942;3550.857965681344;3571.6964058054837;4007.318755811519;4072.144849581621;4081.5102187737066;3575.4279315309427;3583.7670551414076;3594.6045934947133;3618.4029635110437;3649.9635003650155;1151.4742965570651;1162.5466068233395;1183.1658680630308;1183.44378142273;1186.2052424875353;1115.4144074360863;1117.541807858774;1208.848893888264;1219.1283232488813;1247.5072346423112;6954.165500140016;7003.949407588801;7140.642967851587;7154;7196.10048743907;452.1138568405961;452.7736131934033;455.2079381875513;455.3102050393656;467.8970626462173;5444.809431669952;5503.669779813224;5509.669419834822;5521.2270282160525;5522.91715624266;8851.380403371702;8880.467171969702;9055.320850936207;9069.501177435304;9189.127032931861;8968.10318968098;9067.863982040275;9075.54622268884;9083.727488175366;9083.727488175366;6957.79126626202;7068.929310706827;7142.21435642079;7146.428285737128;7202.387797037206;7005.0736047587325;7027.964860175871;7067.5052746307265;7082.575045497287;7085.9645701773225;7772.261635144652;8067.0722866871065;8095.02859656845;8215.507069575844;8250.752477425687;8147.144549822184;8319.958400207961;8440.071592124985;8443.704470343508;8469.5341756204;6683.298253683488;6706.93293067063;6755.392014718699;6769.526133170828;6783.762568310085;7147.070880785464;7171.4979951404985;7208.026916366223;7209.531380460253;7217.891731624135;6767.39093481589;6961.512694111364;6966.721331146698;7116.750913717995;7139.643017849191;6735.360140786617;6740.629265390255;6760.087388202726;6780.050792889098;6906.896396554156;6711.932880671131;6775;6784.7964561063245;6859;6860.897086543606;6148.385161483816;6183.350748171377;6183.536234782319;6193.040078787795;6195.411435913761;6301.873962520815;6314.210723659543;6348.269948955744;6358.841028974312;6365.96817015912 05:19:26 INFO - PROCESS | 28902 | |4;prototype.html;324.3011310625602;329.3215975091312;336.8753561182363;338.85598620586273;342.76520583400355;5800.65196088235;5869.589128760988;5906;5911.940880591198;5936.257967754031;5650.830475085754;5828.358880523139;5847.4152584741505;5854.765809367631;5901.940980590193;4552.704074235164;4557.065801510682;4557.407537020183;4560.33875088112;4566.58900698937;4308.138372325532;4403.537628549005;4415.072834704716;4513.052259025609;4552.8861778455475;4448.199324121657;4454.599086082252;4459.665525085616;4463.888402789924;4475.239209334421;4431.224535706238;4445.488768791598;4447.444069491314;4448.888777780565;4468.084042771224;3933.0560665440375;3937.5668676445566;3956.920861582781;3966.2860685076676;3972.543157536891;5447;5579.414161513064;5599.048161812501;5601.103823388238;5644;5122.743862806882;5151.433342332378;5157.045946499909;5166.302549155854;5174.689518628894;6245.7501699931945;6258.9374106259265;6260.937390626081;6263.561550691454;6268.623882567061;4242.896846819818;4247.256730072225;4249.150169966019;4255.5318914919335;4264.189803937242;6256.906146407808;6516.8696626067685;6520.347965203489;6522.445592124675;6533.803985880384;4340.262155433521;4340.674449416307;4341.869743907688;4342.5874541918465;4347.5217726050105;4382.189294980439;4389.275769497997;4391.473023237232;4392.253316936129;4396.560343965578;5046.998636079385;5107.055194788976;5118.59051275897;5124.052050370693;5129.12804823181;6219.875602487925;6268.843278918063;6277.748890044439;6279.152314437584;6281.7173227204885;1569.0585648610743;1587.515807678646;1588.1424031023118;1588.6504968906822;1588.833172516892;1037.9429131397847;1055.461714525582;1055.5830446973403;1066.4909153547799;1067.2795862792584;5950.375210602911;5950.761969521257;5951.9107213391835;5962.075878238793;5962.642241465526;6235.659333243284;6321.209848768904;6432.035194720829;6435.613863168225;6468.6442245676;5997.010493268562;6007.339192688801;6029.608075475167;6030.396960304022;6043.8186854394435;3454.9654503454644;3522.8238588070494;3524.8061356625117;3525.6121826599056;3526.6297038811067;6562.409383155539;6717.429018533479;6764.458843292623;6770.221424536241;6772.390484856386;6753.425958793558;6758.83102922421;6761.729530818712;6762.289959554274;6764.188297404245;6783.62690052042;6795.38841504267;6795.7961261162245;6801.829954251084;6802.081718967975;6378.90431643535;6541.280459149585;6550.803475895731;6555.082288479522;6560.40956313934;6466.094746735367;6472.029195620695;6472.288048314587;6479.611223326616;6488.026795980641;6722.386627209532;6761.22245941723;6770.424513916175;6778.2205046420295;6783.423409010289;4305.784710764387;4419.071994880982;4448.666350023696;4460.907077765968;4462.24141895885;6429.8714025720155;6473.126127972663;6473.708683109177;6476.190476190476;6480.092787009917;6303;6309.684515774285;6310.6213627182515;6314.842128946813;6316.305206427198;6163.167972323679;6286.465650419766;6302.180716506825;6308.400701933309;6316.399942005502;6218.626882387071;6260;6266.122742815918;6276.686165691788;6278.8430289241305;6412.294647588855;6417.679116044085;6422.967885160544;6423.42189202974;6427.100205971261;6131.570790044832;6228.03465462854;6236.6258024518675;6240.252729235821;6259.937400626118 05:19:26 INFO - PROCESS | 28902 | |5;yui.html;664.3688495928867;715.7208688611439;759.8708219602667;806.4959400374765;823.4894365493393;12817.551385701503;12908.677283067904;12947.805782913263;12984.54554090607;13045.67385815355;12073.154879158463;12617.306048167347;12685.492580296801;12686.492540298377;12688.555900543482;668.3450218785594;675.3887731602907;778.9688412463495;792.4452882981935;796.4305521552089;800.967961281548;802.2899733735657;808.0989696488432;808.3331251717327;808.4623725222749;828.6892415344246;840.0507426607925;842.9241368276854;843.6920524008754;843.8143608406141;696.0916004613977;704.8907419350008;825.3108654273659;839.8614228652265;840.5839109640706;616.0789619518848;618.0975775367968;618.1068356225256;618.9845253868644;621.7544070092288;12354.691132721664;12452;12472.251664900135;12472.251664900135;12481.687957801038;11898.940505297505;12290.139690221687;12387.256764594153;12441.75116497665;12476.126671133025;10451.529681164366;10720.517576709066;10744;10982.615608453745;11010.174236932262;3612.584552776438;3625.3836847735683;3647.5258216431957;3817.9427308590393;3818.9427158592644;43032.3545146823;43255.56744432547;43311.56688433107;43326;43455.56544434547;9591.808163836684;9734.659286924923;9831.655892043744;9917.801643967081;9927.80144397108;16847.15764211809;17312.576239326503;17422.041787701546;17442.47672569825;17443.12784360777;7414.703411863573;7442.813929651694;7443.106827180773;7449.85100297991;7545.660445279976;4032.91934161321;4093.1813637272667;4204.558521355275;4308.633766129851;4311;2992.07245753817;3001.8949336773544;3011.5482677598534;3022.8035177713377;3026.243439140215;525.7266221564842;540.9972950135303;543.4972650298537;555.4390066033335;556.0047514948278;506.40750322122466;572.6863471574874;584.2229834320428;625.6871564217892;660.3000819131736;8170.959145204236;8411.53736544496;8469.449485783405;8705.434146780439;8725.389222754346;512.4926322940262;533.2481201505858;538;538.9703566303891;608.0939400293531;3654.397024490929;3664.6518580734787;3867.9226415471535;3945.230680017369;4264.914701705949;53708.46291537034;55968.44031559714;59796.70101649464;59908;64098.35901641017;46798.53201467942;48035.75982120067;48193.277100843516;49219.753901230266;49322;44245;44363.778181109534;44960.3255951161;45080.77459612746;45544.54455455403;8306.792330191553;8471.237588617054;8663.306935445024;8797.604107815292;8855.97132730376;33775.49336759902;33804;34829.12927176739;34887.82556087305;34998.82500587481;39829.62725963948;40487.190256194124;44406.3339049908;44407.77796110999;45086;10621.522031508446;10966.725831854268;11021.173411993972;11032.724181895517;11534.826977595176;12411.255324680547;12675.619731408073;12713.55502557406;13198.472061117447;13206.867931320949;10781.353118812896;10952.616658416917;10980.505877235704;11232.101431885267;11279.605213817476;9020.548972551478;9603.519824008632;11044.944775276394;11123.666290011313;11470.541178352772;10570.577176912837;10715.946420267848;10833.187510936868;10920.890791091988;11046;9085.545722713705;9157.587908543997;9259.72220833376;9317.767055823659;9477.573509192242;8802.29581633455;9210.263178945803;9486.33595648298;9544.379615324982;9839.508024598885 05:19:26 INFO - PROCESS | 28902 | __end_tp_report 05:19:26 INFO - PROCESS | 28902 | __start_cc_report 05:19:26 INFO - PROCESS | 28902 | _x_x_mozilla_cycle_collect,841 05:19:26 INFO - PROCESS | 28902 | __end_cc_report 05:19:26 INFO - PROCESS | 28902 | __startTimestamp1451999966277__endTimestamp 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | ------- Summary: start ------- 05:19:26 INFO - PROCESS | 28902 | Number of tests: 6 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | [#0] dojo.html Cycles:165 Average:5296.20 Median:5460.67 stddev:580.83 (10.6%) stddev-sans-first:558.04 05:19:26 INFO - PROCESS | 28902 | Values: 3165.3 3221.4 3267.1 3269.1 3300.9 5150.0 5276.5 5281.2 5300.7 5378.0 5236.9 5339.4 5409.6 5413.9 5426.8 4841.4 4844.7 4863.7 4866.3 4913.7 4723.6 4944.3 4969.6 4972.9 5022.3 4759.6 4822.4 4876.5 4882.7 4892.4 4821.2 4832.8 4854.0 4859.0 4891.4 4686.0 4853.1 4854.3 4856.7 4905.3 5053.4 5134.1 5229.6 5257.7 5269.8 5728.7 5740.7 5741.1 5745.6 5747.1 5524.8 5665.4 5766.2 5776.9 5779.5 5260.9 5284.3 5395.2 5413.4 5455.2 5864.4 5865.1 5869.0 5876.6 5904.6 5632.8 5636.9 5638.4 5641.8 5645.7 5446.6 5640.5 5677.7 5733.3 5845.4 5669.9 5679.9 5683.3 5683.6 5684.8 5425.8 5613.8 5618.3 5649.5 5663.3 4305.3 4321.4 4332.2 4436.1 4441.4 3883.5 3915.2 3915.2 3930.8 3948.1 5281.2 5285.4 5288.4 5291.8 5297.3 5522.4 5597.6 5621.4 5633.0 5738.5 5337.0 5340.7 5341.0 5367.2 5377.8 4880.7 4883.6 4897.9 4900.1 4932.0 5694.7 5819.3 5826.1 5925.3 5928.6 5624.5 5715.0 5716.7 5728.6 5773.1 5893.2 5919.9 5929.6 5938.3 5938.8 5437.2 5555.9 5562.5 5700.9 5735.9 5552.6 5564.7 5630.4 5776.2 5807.9 5637.6 5651.2 5656.3 5662.4 5664.1 5633.2 5642.0 5650.9 5651.1 5655.4 5323.5 5396.8 5453.1 5456.2 5591.9 5627.2 5660.4 5663.7 5668.2 5710.8 5460.7 5523.0 5524.4 5530.2 5531.6 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | [#1] ext.html Cycles:180 Average:43224.58 Median:33170.33 stddev:72646.42 (219.0%) stddev-sans-first:72779.43 05:19:26 INFO - PROCESS | 28902 | Values: 513.6 524.9 529.4 549.8 588.9 27949.9 28450.9 28483.3 28486.0 34595.7 37792.6 38038.0 38181.4 38266.6 38297.8 8365.7 8499.4 8525.7 8528.5 8531.1 7326.3 7489.3 8290.3 9816.2 10099.0 9694.0 9907.5 9951.0 9977.8 9983.2 7568.5 9804.6 9919.0 9920.7 9932.7 7383.1 9846.9 10016.8 10097.3 10106.1 35262.8 35659.1 35877.5 35879.8 36003.6 3151.9 3160.8 3205.6 3297.7 3361.4 27630.7 28231.3 28681.9 28799.4 29713.3 3921.7 3937.7 3972.6 4049.6 4051.4 268252.0 268277.0 268680.0 269428.0 269525.0 50022.5 50887.7 55821.4 56178.0 57205.0 51188.0 51230.5 51388.0 51390.0 51433.0 14236.3 14297.6 14307.2 14309.9 14323.6 11504.4 11570.5 11584.9 11597.1 11721.7 18588.7 18672.9 18739.5 18787.0 18827.3 7205.3 7347.9 7414.3 7420.8 7493.6 931.5 951.9 983.8 988.3 999.4 27310.3 27473.6 27972.4 28005.9 28157.4 998.0 1047.6 1058.1 1067.1 1082.5 13540.2 14867.3 15087.9 15495.7 15809.2 313340.0 317412.0 318408.0 318643.0 318922.0 50492.7 50730.7 50751.0 50767.7 50826.5 1317.2 1317.2 1323.4 1335.1 1338.5 23560.0 26552.6 27002.6 27750.6 28068.6 40436.6 40574.4 40854.6 40872.6 40889.4 231759.0 233705.0 234197.0 234527.0 277114.0 24790.9 29982.8 30078.2 30362.4 30476.4 37153.8 38173.6 38378.6 38417.8 38796.8 32379.8 32589.2 32735.0 32788.8 33228.2 33117.8 33222.8 33260.0 33336.0 33606.0 34567.7 34747.0 34761.0 35337.5 35592.2 26503.3 26601.9 29043.4 29546.4 29727.9 22867.8 23009.3 24093.9 24440.8 24555.9 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | [#2] jquery.html Cycles:180 Average:17102.08 Median:10906.46 stddev:23502.69 (215.5%) stddev-sans-first:23534.97 05:19:26 INFO - PROCESS | 28902 | Values: 354.3 355.7 358.0 358.7 359.7 13999.4 14378.3 16200.4 16351.1 17194.6 15761.8 16047.0 16052.3 16063.4 16073.6 4613.2 4869.7 4870.1 4873.3 4873.3 3776.5 3891.3 4801.6 5106.8 6066.8 6001.3 6025.5 6043.5 6043.9 6048.3 5855.4 6016.6 6019.0 6029.5 6032.8 5216.8 5316.7 5331.1 5351.2 5353.5 18927.7 19004.4 19407.3 19681.8 19737.3 1968.6 2075.6 2089.6 2155.9 2186.1 8991.8 9667.6 10354.5 10382.3 13204.3 1781.8 1811.9 1813.6 1912.5 1933.3 54233.0 55814.4 58448.4 60833.0 61206.7 9462.0 9769.2 9990.7 10005.4 10033.2 12795.7 12808.8 12820.2 12827.4 12835.6 7003.1 7053.3 7248.2 7288.4 7328.9 6710.7 6792.4 6807.9 6842.6 6866.6 4359.5 4367.4 4420.2 4428.2 4497.5 1688.8 1756.3 1760.4 1788.9 1796.4 923.2 924.6 958.4 958.6 983.9 16271.4 16825.5 17072.0 17263.2 17276.1 849.7 893.0 898.9 900.5 982.8 8628.7 9125.9 9393.0 9889.3 9985.7 117914.4 118871.0 119034.4 119144.0 119306.0 75888.2 76744.6 78790.0 78867.6 80328.6 1146.9 1148.2 1210.5 1212.2 1238.4 15219.5 15238.8 15601.8 15698.6 16006.8 35662.6 35687.0 35872.3 36632.5 36678.1 26966.7 38214.0 44336.3 45024.1 47214.5 14663.3 14747.6 14752.6 15135.7 15156.0 14215.6 18496.7 18844.7 18916.6 19433.8 12064.5 14043.6 14278.4 14878.1 14975.0 14144.8 14828.3 15045.5 15116.2 15338.7 11671.4 12771.1 14204.5 14895.6 15661.5 13574.2 13638.7 13739.8 13796.4 13876.8 13711.9 14171.0 14297.9 14432.1 14838.6 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | [#3] mootools.html Cycles:180 Average:5242.18 Median:6308.04 stddev:2720.99 (43.1%) stddev-sans-first:2712.12 05:19:26 INFO - PROCESS | 28902 | Values: 1254.9 1433.8 1434.1 1556.5 1734.6 6548.9 7161.1 7262.3 7281.5 7285.0 7368.2 7584.2 7587.4 7589.4 7592.1 2220.3 2240.2 2243.5 2245.6 2249.9 2171.6 2234.6 2237.3 2238.6 2246.0 2187.7 2224.6 2225.7 2262.8 2263.4 2203.4 2222.9 2252.9 2255.7 2256.4 2202.1 2229.5 2237.7 2238.4 2240.2 7349.7 7435.6 7452.7 7461.9 7502.0 4364.7 4418.7 4453.5 4455.3 4456.6 2878.8 2979.1 2984.1 2998.6 3015.2 1022.8 1031.7 1034.8 1057.2 1065.1 9780.0 9780.2 9790.1 9794.4 9799.8 3941.3 3990.2 4005.6 4033.1 4047.2 8580.4 8755.4 8766.9 8772.7 8784.7 4429.1 4440.5 4469.5 4471.5 4476.8 3550.9 3571.7 4007.3 4072.1 4081.5 3575.4 3583.8 3594.6 3618.4 3650.0 1151.5 1162.5 1183.2 1183.4 1186.2 1115.4 1117.5 1208.8 1219.1 1247.5 6954.2 7003.9 7140.6 7154.0 7196.1 452.1 452.8 455.2 455.3 467.9 5444.8 5503.7 5509.7 5521.2 5522.9 8851.4 8880.5 9055.3 9069.5 9189.1 8968.1 9067.9 9075.5 9083.7 9083.7 6957.8 7068.9 7142.2 7146.4 7202.4 7005.1 7028.0 7067.5 7082.6 7086.0 7772.3 8067.1 8095.0 8215.5 8250.8 8147.1 8320.0 8440.1 8443.7 8469.5 6683.3 6706.9 6755.4 6769.5 6783.8 7147.1 7171.5 7208.0 7209.5 7217.9 6767.4 6961.5 6966.7 7116.8 7139.6 6735.4 6740.6 6760.1 6780.1 6906.9 6711.9 6775.0 6784.8 6859.0 6860.9 6148.4 6183.4 6183.5 6193.0 6195.4 6301.9 6314.2 6348.3 6358.8 6366.0 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | [#4] prototype.html Cycles:180 Average:5239.39 Median:5950.57 stddev:1599.37 (26.9%) stddev-sans-first:1560.73 05:19:26 INFO - PROCESS | 28902 | Values: 324.3 329.3 336.9 338.9 342.8 5800.7 5869.6 5906.0 5911.9 5936.3 5650.8 5828.4 5847.4 5854.8 5901.9 4552.7 4557.1 4557.4 4560.3 4566.6 4308.1 4403.5 4415.1 4513.1 4552.9 4448.2 4454.6 4459.7 4463.9 4475.2 4431.2 4445.5 4447.4 4448.9 4468.1 3933.1 3937.6 3956.9 3966.3 3972.5 5447.0 5579.4 5599.0 5601.1 5644.0 5122.7 5151.4 5157.0 5166.3 5174.7 6245.8 6258.9 6260.9 6263.6 6268.6 4242.9 4247.3 4249.2 4255.5 4264.2 6256.9 6516.9 6520.3 6522.4 6533.8 4340.3 4340.7 4341.9 4342.6 4347.5 4382.2 4389.3 4391.5 4392.3 4396.6 5047.0 5107.1 5118.6 5124.1 5129.1 6219.9 6268.8 6277.7 6279.2 6281.7 1569.1 1587.5 1588.1 1588.7 1588.8 1037.9 1055.5 1055.6 1066.5 1067.3 5950.4 5950.8 5951.9 5962.1 5962.6 6235.7 6321.2 6432.0 6435.6 6468.6 5997.0 6007.3 6029.6 6030.4 6043.8 3455.0 3522.8 3524.8 3525.6 3526.6 6562.4 6717.4 6764.5 6770.2 6772.4 6753.4 6758.8 6761.7 6762.3 6764.2 6783.6 6795.4 6795.8 6801.8 6802.1 6378.9 6541.3 6550.8 6555.1 6560.4 6466.1 6472.0 6472.3 6479.6 6488.0 6722.4 6761.2 6770.4 6778.2 6783.4 4305.8 4419.1 4448.7 4460.9 4462.2 6429.9 6473.1 6473.7 6476.2 6480.1 6303.0 6309.7 6310.6 6314.8 6316.3 6163.2 6286.5 6302.2 6308.4 6316.4 6218.6 6260.0 6266.1 6276.7 6278.8 6412.3 6417.7 6423.0 6423.4 6427.1 6131.6 6228.0 6236.6 6240.3 6259.9 05:19:26 INFO - PROCESS | 28902 | 05:19:26 INFO - PROCESS | 28902 | [#5] yui.html Cycles:180 Average:13359.71 Median:45083.39 stddev:15403.63 (34.2%) stddev-sans-first:15417.34 05:19:26 INFO - PROCESS | 28902 | Values: 664.4 715.7 759.9 806.5 823.5 12817.6 12908.7 12947.8 12984.5 13045.7 12073.2 12617.3 12685.5 12686.5 12688.6 668.3 675.4 779.0 792.4 796.4 801.0 802.3 808.1 808.3 808.5 828.7 840.1 842.9 843.7 843.8 696.1 704.9 825.3 839.9 840.6 616.1 618.1 618.1 619.0 621.8 12354.7 12452.0 12472.3 12472.3 12481.7 11898.9 12290.1 12387.3 12441.8 12476.1 10451.5 10720.5 10744.0 10982.6 11010.2 3612.6 3625.4 3647.5 3817.9 3818.9 43032.4 43255.6 43311.6 43326.0 43455.6 9591.8 9734.7 9831.7 9917.8 9927.8 16847.2 17312.6 17422.0 17442.5 17443.1 7414.7 7442.8 7443.1 7449.9 7545.7 4032.9 4093.2 4204.6 4308.6 4311.0 2992.1 3001.9 3011.5 3022.8 3026.2 525.7 541.0 543.5 555.4 556.0 506.4 572.7 584.2 625.7 660.3 8171.0 8411.5 8469.4 8705.4 8725.4 512.5 533.2 538.0 539.0 608.1 3654.4 3664.7 3867.9 3945.2 4264.9 53708.5 55968.4 59796.7 59908.0 64098.4 46798.5 48035.8 48193.3 49219.8 49322.0 44245.0 44363.8 44960.3 45080.8 45544.5 8306.8 8471.2 8663.3 8797.6 8856.0 33775.5 33804.0 34829.1 34887.8 34998.8 39829.6 40487.2 44406.3 44407.8 45086.0 10621.5 10966.7 11021.2 11032.7 11534.8 12411.3 12675.6 12713.6 13198.5 13206.9 10781.4 10952.6 10980.5 11232.1 11279.6 9020.5 9603.5 11044.9 11123.7 11470.5 10570.6 10715.9 10833.2 10920.9 11046.0 9085.5 9157.6 9259.7 9317.8 9477.6 8802.3 9210.3 9486.3 9544.4 9839.5 05:19:26 INFO - PROCESS | 28902 | -------- Summary: end -------- 05:19:26 INFO - PROCESS | 28902 | 05:19:27 INFO - TEST-INFO | 28902: exit 0 05:19:27 INFO - TEST-OK | dromaeo_css | took 1112501ms 05:19:27 INFO - TEST-START | kraken 05:19:27 INFO - operating with platform_type : linux_ 05:19:27 INFO - Initialising browser for kraken test... 05:19:27 INFO - TEST-INFO | started process 29098 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYxAac6/profile http://localhost:38424/getInfo.html) 05:19:30 INFO - PROCESS | 29098 | __metrics Screen width/height:1600/1200 05:19:30 INFO - PROCESS | 29098 | colorDepth:24 05:19:30 INFO - PROCESS | 29098 | Browser inner width/height: 1024/697 05:19:30 INFO - PROCESS | 29098 | __metrics 05:19:30 INFO - PROCESS | 29098 | 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:19:30 INFO - PROCESS | 29098 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:31 INFO - TEST-INFO | 29098: exit 0 05:19:31 INFO - Browser initialized. 05:19:31 INFO - Running cycle 1/1 for kraken test... 05:19:31 INFO - TEST-INFO | started process 29181 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYxAac6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:43 INFO - PROCESS | 29181 | RSS: Main: 150077440 05:19:43 INFO - PROCESS | 29181 | 05:19:45 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38424/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:46 INFO - PROCESS | 29181 | RSS: Main: 185061376 05:19:46 INFO - PROCESS | 29181 | 05:19:49 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38424/tests/kraken/driver.html?testName=audio-dft) 05:19:49 INFO - PROCESS | 29181 | RSS: Main: 175915008 05:19:49 INFO - PROCESS | 29181 | 05:19:52 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38424/tests/kraken/driver.html?testName=audio-fft) 05:19:53 INFO - PROCESS | 29181 | RSS: Main: 160620544 05:19:53 INFO - PROCESS | 29181 | 05:19:55 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38424/tests/kraken/driver.html?testName=audio-oscillator) 05:19:55 INFO - PROCESS | 29181 | RSS: Main: 162717696 05:19:55 INFO - PROCESS | 29181 | 05:19:57 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:58 INFO - PROCESS | 29181 | RSS: Main: 165777408 05:19:58 INFO - PROCESS | 29181 | 05:20:01 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38424/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:01 INFO - PROCESS | 29181 | RSS: Main: 163676160 05:20:01 INFO - PROCESS | 29181 | 05:20:05 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38424/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:05 INFO - PROCESS | 29181 | RSS: Main: 164454400 05:20:05 INFO - PROCESS | 29181 | 05:20:08 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38424/tests/kraken/driver.html?testName=json-parse-financial) 05:20:09 INFO - PROCESS | 29181 | RSS: Main: 164352000 05:20:09 INFO - PROCESS | 29181 | 05:20:10 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:11 INFO - PROCESS | 29181 | RSS: Main: 182538240 05:20:11 INFO - PROCESS | 29181 | 05:20:13 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:13 INFO - PROCESS | 29181 | RSS: Main: 176685056 05:20:13 INFO - PROCESS | 29181 | 05:20:15 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:16 INFO - PROCESS | 29181 | RSS: Main: 183660544 05:20:16 INFO - PROCESS | 29181 | 05:20:18 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:19 INFO - PROCESS | 29181 | RSS: Main: 193695744 05:20:19 INFO - PROCESS | 29181 | 05:20:22 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:22 INFO - PROCESS | 29181 | RSS: Main: 190603264 05:20:22 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | Cycle 1(1): loaded http://localhost:38424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38424/tests/kraken/driver.html?testName=ai-astar) 05:20:24 INFO - PROCESS | 29181 | RSS: Main: 247562240 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | __start_tp_report 05:20:24 INFO - PROCESS | 29181 | _x_x_mozilla_page_load 05:20:24 INFO - PROCESS | 29181 | _x_x_mozilla_page_load_details 05:20:24 INFO - PROCESS | 29181 | |i|pagename|runs| 05:20:24 INFO - PROCESS | 29181 | |0;ai-astar;109;111;104;112;113;110;101;113;112;111 05:20:24 INFO - PROCESS | 29181 | |1;audio-beat-detection;154;126;151;170;124;152;157;125;166;127 05:20:24 INFO - PROCESS | 29181 | |2;audio-dft;160;162;160;161;161;162;161;164;160;162 05:20:24 INFO - PROCESS | 29181 | |3;audio-fft;72;73;85;93;72;71;71;107;90;70 05:20:24 INFO - PROCESS | 29181 | |4;audio-oscillator;96;97;139;97;96;96;144;97;96;143 05:20:24 INFO - PROCESS | 29181 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;109 05:20:24 INFO - PROCESS | 29181 | |6;imaging-darkroom;146;146;146;146;146;146;145;145;145;146 05:20:24 INFO - PROCESS | 29181 | |7;imaging-desaturate;96;95;96;95;96;95;95;95;96;95 05:20:24 INFO - PROCESS | 29181 | |8;json-parse-financial;57;58;60;58;56;58;59;57;62;55 05:20:24 INFO - PROCESS | 29181 | |9;json-stringify-tinderbox;67;67;66;67;67;67;67;66;68;68 05:20:24 INFO - PROCESS | 29181 | |10;stanford-crypto-aes;93;85;86;86;85;85;86;84;85;87 05:20:24 INFO - PROCESS | 29181 | |11;stanford-crypto-ccm;116;125;133;116;119;126;125;117;125;122 05:20:24 INFO - PROCESS | 29181 | |12;stanford-crypto-pbkdf2;154;152;154;157;153;147;154;164;154;142 05:20:24 INFO - PROCESS | 29181 | |13;stanford-crypto-sha256-iterative;68;70;70;69;68;67;67;67;68;67 05:20:24 INFO - PROCESS | 29181 | __end_tp_report 05:20:24 INFO - PROCESS | 29181 | __start_cc_report 05:20:24 INFO - PROCESS | 29181 | _x_x_mozilla_cycle_collect,929 05:20:24 INFO - PROCESS | 29181 | __end_cc_report 05:20:24 INFO - PROCESS | 29181 | __startTimestamp1452000024520__endTimestamp 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | ------- Summary: start ------- 05:20:24 INFO - PROCESS | 29181 | Number of tests: 14 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 05:20:24 INFO - PROCESS | 29181 | Values: 109.0 111.0 104.0 112.0 113.0 110.0 101.0 113.0 112.0 111.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.00 stddev:17.96 (11.7%) stddev-sans-first:18.76 05:20:24 INFO - PROCESS | 29181 | Values: 154.0 126.0 151.0 170.0 124.0 152.0 157.0 125.0 166.0 127.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 05:20:24 INFO - PROCESS | 29181 | Values: 160.0 162.0 160.0 161.0 161.0 162.0 161.0 164.0 160.0 162.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#3] audio-fft Cycles:10 Average:80.40 Median:72.50 stddev:12.74 (17.6%) stddev-sans-first:13.14 05:20:24 INFO - PROCESS | 29181 | Values: 72.0 73.0 85.0 93.0 72.0 71.0 71.0 107.0 90.0 70.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.05 (23.0%) stddev-sans-first:22.79 05:20:24 INFO - PROCESS | 29181 | Values: 96.0 97.0 139.0 97.0 96.0 96.0 144.0 97.0 96.0 143.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:20:24 INFO - PROCESS | 29181 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:20:24 INFO - PROCESS | 29181 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:20:24 INFO - PROCESS | 29181 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:2.00 (3.4%) stddev-sans-first:2.09 05:20:24 INFO - PROCESS | 29181 | Values: 57.0 58.0 60.0 58.0 56.0 58.0 59.0 57.0 62.0 55.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:20:24 INFO - PROCESS | 29181 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 68.0 68.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.53 (2.9%) stddev-sans-first:0.88 05:20:24 INFO - PROCESS | 29181 | Values: 93.0 85.0 86.0 86.0 85.0 85.0 86.0 84.0 85.0 87.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:125.00 stddev:5.46 (4.4%) stddev-sans-first:5.28 05:20:24 INFO - PROCESS | 29181 | Values: 116.0 125.0 133.0 116.0 119.0 126.0 125.0 117.0 125.0 122.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:5.76 (3.7%) stddev-sans-first:6.10 05:20:24 INFO - PROCESS | 29181 | Values: 154.0 152.0 154.0 157.0 153.0 147.0 154.0 164.0 154.0 142.0 05:20:24 INFO - PROCESS | 29181 | 05:20:24 INFO - PROCESS | 29181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 05:20:24 INFO - PROCESS | 29181 | Values: 68.0 70.0 70.0 69.0 68.0 67.0 67.0 67.0 68.0 67.0 05:20:24 INFO - PROCESS | 29181 | -------- Summary: end -------- 05:20:24 INFO - PROCESS | 29181 | 05:20:25 INFO - TEST-INFO | 29181: exit 0 05:20:25 INFO - TEST-OK | kraken | took 58362ms 05:20:25 INFO - TEST-START | v8_7 05:20:25 INFO - operating with platform_type : linux_ 05:20:25 INFO - Initialising browser for v8_7 test... 05:20:25 INFO - TEST-INFO | started process 29432 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKy2AAl/profile http://localhost:38424/getInfo.html) 05:20:29 INFO - PROCESS | 29432 | __metrics Screen width/height:1600/1200 05:20:29 INFO - PROCESS | 29432 | colorDepth:24 05:20:29 INFO - PROCESS | 29432 | Browser inner width/height: 1024/697 05:20:29 INFO - PROCESS | 29432 | __metrics 05:20:29 INFO - PROCESS | 29432 | 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:20:29 INFO - PROCESS | 29432 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:30 INFO - TEST-INFO | 29432: exit 0 05:20:30 INFO - Browser initialized. 05:20:30 INFO - Running cycle 1/1 for v8_7 test... 05:20:30 INFO - TEST-INFO | started process 29515 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKy2AAl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:41 INFO - PROCESS | 29515 | RSS: Main: 149762048 05:20:41 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | Cycle 1(1): loaded http://localhost:38424/tests/v8_7/run.html (next: http://localhost:38424/tests/v8_7/run.html) 05:21:03 INFO - PROCESS | 29515 | RSS: Main: 613392384 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | __start_tp_report 05:21:03 INFO - PROCESS | 29515 | _x_x_mozilla_page_load 05:21:03 INFO - PROCESS | 29515 | _x_x_mozilla_page_load_details 05:21:03 INFO - PROCESS | 29515 | |i|pagename|runs| 05:21:03 INFO - PROCESS | 29515 | |0;Richards;167.42005692281936 05:21:03 INFO - PROCESS | 29515 | |1;DeltaBlue;191.20458891013385 05:21:03 INFO - PROCESS | 29515 | |2;Encrypt;280.2690582959641 05:21:03 INFO - PROCESS | 29515 | |3;Decrypt;5164.948453608247 05:21:03 INFO - PROCESS | 29515 | |4;RayTrace;1949.317738791423 05:21:03 INFO - PROCESS | 29515 | |5;Earley;796.3404932378679 05:21:03 INFO - PROCESS | 29515 | |6;Boyer;12600 05:21:03 INFO - PROCESS | 29515 | |7;RegExp;25948.71794871795 05:21:03 INFO - PROCESS | 29515 | |8;Splay;673.1283422459893 05:21:03 INFO - PROCESS | 29515 | |9;NavierStokes;4840.579710144928 05:21:03 INFO - PROCESS | 29515 | __end_tp_report 05:21:03 INFO - PROCESS | 29515 | __startTimestamp1452000063609__endTimestamp 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | ------- Summary: start ------- 05:21:03 INFO - PROCESS | 29515 | Number of tests: 10 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 167.4 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 191.2 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 280.3 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 5164.9 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#4] RayTrace Cycles:1 Average:1949.32 Median:1949.32 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 1949.3 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#5] Earley Cycles:1 Average:796.34 Median:796.34 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 796.3 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#6] Boyer Cycles:1 Average:12600.00 Median:12600.00 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 12600.0 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 25948.7 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#8] Splay Cycles:1 Average:673.13 Median:673.13 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 673.1 05:21:03 INFO - PROCESS | 29515 | 05:21:03 INFO - PROCESS | 29515 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:21:03 INFO - PROCESS | 29515 | Values: 4840.6 05:21:03 INFO - PROCESS | 29515 | -------- Summary: end -------- 05:21:03 INFO - PROCESS | 29515 | 05:21:04 INFO - TEST-INFO | 29515: exit 0 05:21:04 INFO - TEST-OK | v8_7 | took 39061ms 05:21:04 INFO - SUITE-END | took 1209s 05:21:04 INFO - Completed test suite (00:20:10) 05:21:04 INFO - Working with test: dromaeo_css 05:21:04 INFO - Generating results file: dromaeo_css 05:21:04 INFO - Working with test: kraken 05:21:04 INFO - Generating results file: kraken 05:21:04 INFO - javascript benchmark 05:21:04 INFO - Working with test: v8_7 05:21:04 INFO - Generating results file: v8_7 05:21:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:21:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:21:04 INFO - process_Request line: dromaeo_css 6778.19 graph.html#tests=[[72,64,35]] 05:21:04 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:21:04 INFO - process_Request line: kraken 1511.60 graph.html#tests=[[232,64,35]] 05:21:04 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:21:04 INFO - process_Request line: v8_7 19542.59 graph.html#tests=[[230,64,35]] 05:21:04 INFO - RETURN: dromaeo_css: 6778.19 05:21:04 INFO - RETURN: kraken: 1511.60 05:21:04 INFO - RETURN: v8_7: 19542.59 05:21:04 INFO - javascript benchmark 05:21:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3165.256164801271, 3221.4362486564846, 3267.05255475912, 3269.084656296238, 3300.917477063073, 5149.974250128744, 5276.498732620405, 5281.234221037952, 5300.6819590824525, 5378.031954248228, 5236.895262094766, 5339.385970613371, 5409.6213265071465, 5413.918791218135, 5426.8371948841495, 4841.394825646794, 4844.733539655326, 4863.732494712789, 4866.294387313855, 4913.705177689332, 4723.551262630044, 4944.283078953567, 4969.577585905203, 4972.900541989158, 5022.321986531826, 4759.595434388081, 4822.397200349974, 4876.487968763265, 4882.6826256293225, 4892.3884514435695, 4821.228603423436, 4832.7825247863575, 4853.95146048542, 4859.028194361142, 4891.413030436335, 4685.976570117127, 4853.102176097398, 4854.320395144682, 4856.732879691615, 4905.3132561441425, 5053.444121146671, 5134.101532231882, 5229.555487783543, 5257.737113144328, 5269.762860671241, 5728.68492232927, 5740.684262365568, 5741.081426971665, 5745.597808153431, 5747.109198074263, 5524.751386187631, 5665.3768085510565, 5766.163906233573, 5776.913346299809, 5779.508741756956, 5260.894782104375, 5284.339457567804, 5395.163749618815, 5413.377461591967, 5455.18172274162, 5864.354920958691, 5865.149553314831, 5869.0, 5876.647401155944, 5904.5571582131515, 5632.831015069554, 5636.887262254732, 5638.43615638441, 5641.80253691127, 5645.745941432645, 5446.645968012067, 5640.520555752725, 5677.716114194356, 5733.3406658234, 5845.386234445407, 5669.886602267931, 5679.8864022720145, 5683.346415162227, 5683.573731970118, 5684.8010319638615, 5425.755840987165, 5613.803516876889, 5618.269624948813, 5649.4633009864, 5663.348714897839, 4305.268104422255, 4321.438213032286, 4332.155229730235, 4436.068425630654, 4441.378207051015, 3883.456316115746, 3915.1778126593163, 3915.197384536163, 3930.76415415076, 3948.072203032285, 5281.15501519755, 5285.445028272053, 5288.391834938954, 5291.788328466895, 5297.258383826267, 5522.447755224445, 5597.63615365, 5621.409751976065, 5633.014222511044, 5738.540916726652, 5337.0, 5340.679559226459, 5341.0, 5367.221752845816, 5377.78488860449, 4880.731559764176, 4883.609311255091, 4897.926531102036, 4900.14247506692, 4932.0, 5694.743736531866, 5819.330776960704, 5826.096954971986, 5925.34821169671, 5928.584999050025, 5624.465675760796, 5714.971425143014, 5716.714164291686, 5728.570357223141, 5773.134029895549, 5893.174955506318, 5919.911201331897, 5929.555283353679, 5938.287405511366, 5938.762449501972, 5437.157240627709, 5555.944440555542, 5562.471565201299, 5700.885982280414, 5735.942640573541, 5552.5557955362665, 5564.749586268546, 5630.352509461464, 5776.19133321327, 5807.94192058074, 5637.605367624227, 5651.15232715096, 5656.349519805275, 5662.377138514677, 5664.122061080539, 5633.2395126657375, 5641.971790141023, 5650.85872853182, 5651.095824668033, 5655.377908430151, 5323.467653234646, 5396.757145928521, 5453.072977593739, 5456.236126942152, 5591.916121258266, 5627.18405831144, 5660.433956604471, 5663.716814159358, 5668.178114173505, 5710.771569137188, 5460.672359658433, 5523.033469142803, 5524.392316845224, 5530.170474428707, 5531.585131115263], "unit": "score", "name": "dojo.html", "value": 5259.370477541273}, {"lowerIsBetter": false, "replicates": [513.5968264912043, 524.9265102885596, 529.4255732530205, 549.8103154411727, 588.8881112588605, 27949.860250698744, 28450.857745711295, 28483.287917802067, 28486.011958325824, 34595.65404345956, 37792.622073779254, 38038.0, 38181.42727859085, 38266.61733382665, 38297.80851095741, 8365.665373385058, 8499.36254780894, 8525.701600443987, 8528.488290702579, 8531.104234055429, 7326.340629343358, 7489.28851759082, 8290.253877151055, 9816.214702823758, 10099.0, 9694.0, 9907.455089970048, 9951.0, 9977.75055623608, 9983.151432128278, 7568.508046976929, 9804.607815687365, 9918.950405247928, 9920.702378928643, 9932.6523571675, 7383.114026316823, 9846.90153098467, 10016.799664006752, 10097.343672661253, 10106.140978016878, 35262.823685881405, 35659.10852228689, 35877.46183807219, 35879.82060089709, 36003.63996360029, 3151.8739250429953, 3160.7787454878166, 3205.5832741743657, 3297.7032067113837, 3361.445361515347, 27630.72369276322, 28231.294217644518, 28681.890052589446, 28799.424011519863, 29713.25716857096, 3921.686265098785, 3937.6652984496354, 3972.5828787977134, 4049.5545489996075, 4051.4327994080854, 268252.0, 268277.0, 268680.0, 269428.0, 269525.0, 50022.499775002514, 50887.74556127196, 55821.441785582436, 56178.0, 57205.0, 51188.0, 51230.48769512332, 51388.0, 51390.0, 51433.0, 14236.28818559068, 14297.642558935902, 14307.213103279211, 14309.92675549338, 14323.57029289123, 11504.367259800623, 11570.537178512934, 11584.94207528957, 11597.13021523389, 11721.706957325965, 18588.721169182474, 18672.906635466737, 18739.531511712044, 18787.0, 18827.34104306343, 7205.279472052753, 7347.88978165328, 7414.332710056121, 7420.814479637944, 7493.625318734151, 931.4550987672287, 951.8714973478492, 983.8229118758692, 988.3081842710131, 999.4303247149055, 27310.317242069108, 27473.587896181572, 27972.44055118886, 28005.859970700018, 28157.43685126286, 998.0119681515248, 1047.643801107627, 1058.1270451877078, 1067.1356201476829, 1082.5345101606226, 13540.187588744708, 14867.256637168315, 15087.858631986455, 15495.690086198212, 15809.209539522977, 313340.0, 317412.0, 318408.0, 318643.0, 318922.0, 50492.74753626208, 50730.746346268774, 50751.0, 50767.74616126896, 50826.49173508291, 1317.1636011133, 1317.1965101288206, 1323.3846261488454, 1335.0787956310114, 1338.491373278148, 23560.0, 26552.601710974737, 27002.594961075993, 27750.583741243492, 28068.578971315037, 40436.59563404328, 40574.39138412985, 40854.59145408508, 40872.59127408688, 40889.38665920073, 231759.0, 233705.0, 234197.0, 234527.0, 277114.0, 24790.876045620378, 29982.80240766338, 30078.24804379908, 30362.39275214439, 30476.390472190877, 37153.81423092867, 38173.61826381812, 38378.61621383862, 38417.80791096027, 38796.80601596974, 32379.838100810288, 32589.18527036843, 32735.0, 32788.83605581957, 33228.169295766835, 33117.83441082779, 33222.83388583042, 33260.0, 33336.0, 33606.0, 34567.65432345745, 34747.0, 34761.0, 35337.469937951464, 35592.22038897993, 26503.33741656397, 26601.866990664923, 29043.419131616825, 29546.409071818875, 29727.851360743058, 22867.771322286564, 23009.309720708407, 24093.879530602233, 24440.75559244385, 24555.877220613784], "unit": "score", "name": "ext.html", "value": 17537.42859368898}, {"lowerIsBetter": false, "replicates": [354.29848899179626, 355.6976569915572, 358.02973940620916, 358.739913562667, 359.6619177972705, 13999.440022399118, 14378.281085945688, 16200.351985920564, 16351.100689462075, 17194.570135746613, 15761.842381576182, 16047.037177769342, 16052.277647505862, 16063.437779677713, 16073.598160046005, 4613.1696294666945, 4869.707817530942, 4870.099031679133, 4873.293372460991, 4873.293372461008, 3776.4901738265394, 3891.3190191716476, 4801.61587073035, 5106.821261255838, 6066.787662431816, 6001.309849367335, 6025.517958563304, 6043.546733994946, 6043.879122417549, 6048.334683184846, 5855.414458554132, 6016.608920420159, 6019.036954087369, 6029.517638588903, 6032.819015429544, 5216.843494695166, 5316.73416329182, 5331.067063263913, 5351.197320401932, 5353.518183363477, 18927.716084258747, 19004.42986710401, 19407.320743774042, 19681.803181968142, 19737.309194178277, 1968.5570746582048, 2075.6056349293585, 2089.634313995045, 2155.948959992854, 2186.1146235774536, 8991.775205619846, 9667.564959576835, 10354.53404596795, 10382.273240873143, 13204.339783010812, 1781.750554922312, 1811.8641101917408, 1813.6010077782867, 1912.4549503391468, 1933.3040105562127, 54233.0, 55814.44185558133, 58448.41551584515, 60833.0, 61206.69396653033, 9462.0, 9769.16962058233, 9990.650327238513, 10005.449700266556, 10033.247506437046, 12795.744085118245, 12808.80786788199, 12820.166689165175, 12827.358632068359, 12835.614931552069, 7003.124609423822, 7053.294670532906, 7248.202697703248, 7288.380487658608, 7328.926710732824, 6710.698018589175, 6792.388685018372, 6807.897881531781, 6842.623655698984, 6866.622335771581, 4359.520452750195, 4367.432233809584, 4420.160169567772, 4428.158649856517, 4497.527759585262, 1688.8480036796748, 1756.262369804685, 1760.392664530735, 1788.8926664399917, 1796.4161647464625, 923.1783712495884, 924.5654542365078, 958.4393130018877, 958.5878072428783, 983.9458829764432, 16271.430499932445, 16825.495235142964, 17071.973584400595, 17263.223154958057, 17276.13619319029, 849.6516428264382, 893.0489029184029, 898.8786513820681, 900.5317235037744, 982.8230918434607, 8628.654853805778, 9125.863112053325, 9393.0, 9889.307748457539, 9985.650502232387, 117914.41042794903, 118871.0, 119034.4048279753, 119144.0, 119306.0, 75888.24111758811, 76744.61627691826, 78790.0, 78867.60566197132, 80328.59835700784, 1146.931184128955, 1148.1847887999447, 1210.5339444314002, 1212.2241765270235, 1238.3931873382157, 15219.543413697163, 15238.847611523743, 15601.84398156004, 15698.607534811721, 16006.839931600534, 35662.64337356593, 35687.0, 35872.28255434825, 36632.45051324285, 36678.08304792402, 26966.730332697207, 38214.0, 44336.33495497506, 45024.14686090787, 47214.52785472101, 14663.266836657911, 14747.55757327282, 14752.55742327732, 15135.697286053997, 15156.0, 14215.573532794033, 18496.72254916204, 18844.717329240346, 18916.621667566847, 19433.805661943767, 12064.457099430721, 14043.648908777363, 14278.428862845785, 14878.10731356122, 14975.0, 14144.78782818238, 14828.332725027183, 15045.548633541011, 15116.168610726516, 15338.693226135638, 11671.416429178676, 12771.106022578702, 14204.502842400467, 14895.627609309853, 15661.451849185223, 13574.185548867099, 13638.727225455634, 13739.793903091262, 13796.448142074205, 13876.791848122488, 13711.862881371457, 14171.0, 14297.857021429652, 14432.061915975848, 14838.629034274229], "unit": "score", "name": "jquery.html", "value": 8606.804248078735}, {"lowerIsBetter": false, "replicates": [1254.887060164585, 1433.7992681024655, 1434.0965191929083, 1556.4785796758085, 1734.6010417603943, 6548.934510654892, 7161.104861892263, 7262.310080542353, 7281.453890958172, 7285.0, 7368.2263362346985, 7584.241575842413, 7587.393008559316, 7589.392848572114, 7592.088949326075, 2220.311703371952, 2240.204727321802, 2243.5288589396246, 2245.5621153875, 2249.910003599854, 2171.554831259596, 2234.6089434349005, 2237.3064350051454, 2238.6418173092306, 2245.9663105053437, 2187.726534183227, 2224.5995720770256, 2225.7440394354694, 2262.751097379287, 2263.366257447909, 2203.372038968886, 2222.9333120006345, 2252.8986195621237, 2255.6616507523922, 2256.379495638696, 2202.0751284460407, 2229.5317983223545, 2237.7202849643795, 2238.3620668109675, 2240.215924426454, 7349.7060117595765, 7435.591042492661, 7452.664630091659, 7461.925380746177, 7501.962490187569, 4364.694471387004, 4418.690691651585, 4453.53237910018, 4455.309427038814, 4456.598906098434, 2878.7984841061134, 2979.0764862892356, 2984.0749367696085, 2998.5502174673757, 3015.200971742468, 1022.8056669232822, 1031.6750223679517, 1034.7775228325945, 1057.154276578734, 1065.1053115383038, 9780.0, 9780.168685661727, 9790.069943355442, 9794.412335259836, 9799.755006124762, 3941.2905676977844, 3990.20195960809, 4005.559388467266, 4033.1127152026506, 4047.170330082326, 8580.442271252348, 8755.430896991802, 8766.912330876738, 8772.736817895473, 8784.692535761218, 4429.11417716458, 4440.489343725449, 4469.486009108994, 4471.485779135441, 4476.820927162942, 3550.857965681344, 3571.6964058054837, 4007.318755811519, 4072.144849581621, 4081.5102187737066, 3575.4279315309427, 3583.7670551414076, 3594.6045934947133, 3618.4029635110437, 3649.9635003650155, 1151.4742965570651, 1162.5466068233395, 1183.1658680630308, 1183.44378142273, 1186.2052424875353, 1115.4144074360863, 1117.541807858774, 1208.848893888264, 1219.1283232488813, 1247.5072346423112, 6954.165500140016, 7003.949407588801, 7140.642967851587, 7154.0, 7196.10048743907, 452.1138568405961, 452.7736131934033, 455.2079381875513, 455.3102050393656, 467.8970626462173, 5444.809431669952, 5503.669779813224, 5509.669419834822, 5521.2270282160525, 5522.91715624266, 8851.380403371702, 8880.467171969702, 9055.320850936207, 9069.501177435304, 9189.127032931861, 8968.10318968098, 9067.863982040275, 9075.54622268884, 9083.727488175366, 9083.727488175366, 6957.79126626202, 7068.929310706827, 7142.21435642079, 7146.428285737128, 7202.387797037206, 7005.0736047587325, 7027.964860175871, 7067.5052746307265, 7082.575045497287, 7085.9645701773225, 7772.261635144652, 8067.0722866871065, 8095.02859656845, 8215.507069575844, 8250.752477425687, 8147.144549822184, 8319.958400207961, 8440.071592124985, 8443.704470343508, 8469.5341756204, 6683.298253683488, 6706.93293067063, 6755.392014718699, 6769.526133170828, 6783.762568310085, 7147.070880785464, 7171.4979951404985, 7208.026916366223, 7209.531380460253, 7217.891731624135, 6767.39093481589, 6961.512694111364, 6966.721331146698, 7116.750913717995, 7139.643017849191, 6735.360140786617, 6740.629265390255, 6760.087388202726, 6780.050792889098, 6906.896396554156, 6711.932880671131, 6775.0, 6784.7964561063245, 6859.0, 6860.897086543606, 6148.385161483816, 6183.350748171377, 6183.536234782319, 6193.040078787795, 6195.411435913761, 6301.873962520815, 6314.210723659543, 6348.269948955744, 6358.841028974312, 6365.96817015912], "unit": "score", "name": "mootools.html", "value": 4244.760152380888}, {"lowerIsBetter": false, "replicates": [324.3011310625602, 329.3215975091312, 336.8753561182363, 338.85598620586273, 342.76520583400355, 5800.65196088235, 5869.589128760988, 5906.0, 5911.940880591198, 5936.257967754031, 5650.830475085754, 5828.358880523139, 5847.4152584741505, 5854.765809367631, 5901.940980590193, 4552.704074235164, 4557.065801510682, 4557.407537020183, 4560.33875088112, 4566.58900698937, 4308.138372325532, 4403.537628549005, 4415.072834704716, 4513.052259025609, 4552.8861778455475, 4448.199324121657, 4454.599086082252, 4459.665525085616, 4463.888402789924, 4475.239209334421, 4431.224535706238, 4445.488768791598, 4447.444069491314, 4448.888777780565, 4468.084042771224, 3933.0560665440375, 3937.5668676445566, 3956.920861582781, 3966.2860685076676, 3972.543157536891, 5447.0, 5579.414161513064, 5599.048161812501, 5601.103823388238, 5644.0, 5122.743862806882, 5151.433342332378, 5157.045946499909, 5166.302549155854, 5174.689518628894, 6245.7501699931945, 6258.9374106259265, 6260.937390626081, 6263.561550691454, 6268.623882567061, 4242.896846819818, 4247.256730072225, 4249.150169966019, 4255.5318914919335, 4264.189803937242, 6256.906146407808, 6516.8696626067685, 6520.347965203489, 6522.445592124675, 6533.803985880384, 4340.262155433521, 4340.674449416307, 4341.869743907688, 4342.5874541918465, 4347.5217726050105, 4382.189294980439, 4389.275769497997, 4391.473023237232, 4392.253316936129, 4396.560343965578, 5046.998636079385, 5107.055194788976, 5118.59051275897, 5124.052050370693, 5129.12804823181, 6219.875602487925, 6268.843278918063, 6277.748890044439, 6279.152314437584, 6281.7173227204885, 1569.0585648610743, 1587.515807678646, 1588.1424031023118, 1588.6504968906822, 1588.833172516892, 1037.9429131397847, 1055.461714525582, 1055.5830446973403, 1066.4909153547799, 1067.2795862792584, 5950.375210602911, 5950.761969521257, 5951.9107213391835, 5962.075878238793, 5962.642241465526, 6235.659333243284, 6321.209848768904, 6432.035194720829, 6435.613863168225, 6468.6442245676, 5997.010493268562, 6007.339192688801, 6029.608075475167, 6030.396960304022, 6043.8186854394435, 3454.9654503454644, 3522.8238588070494, 3524.8061356625117, 3525.6121826599056, 3526.6297038811067, 6562.409383155539, 6717.429018533479, 6764.458843292623, 6770.221424536241, 6772.390484856386, 6753.425958793558, 6758.83102922421, 6761.729530818712, 6762.289959554274, 6764.188297404245, 6783.62690052042, 6795.38841504267, 6795.7961261162245, 6801.829954251084, 6802.081718967975, 6378.90431643535, 6541.280459149585, 6550.803475895731, 6555.082288479522, 6560.40956313934, 6466.094746735367, 6472.029195620695, 6472.288048314587, 6479.611223326616, 6488.026795980641, 6722.386627209532, 6761.22245941723, 6770.424513916175, 6778.2205046420295, 6783.423409010289, 4305.784710764387, 4419.071994880982, 4448.666350023696, 4460.907077765968, 4462.24141895885, 6429.8714025720155, 6473.126127972663, 6473.708683109177, 6476.190476190476, 6480.092787009917, 6303.0, 6309.684515774285, 6310.6213627182515, 6314.842128946813, 6316.305206427198, 6163.167972323679, 6286.465650419766, 6302.180716506825, 6308.400701933309, 6316.399942005502, 6218.626882387071, 6260.0, 6266.122742815918, 6276.686165691788, 6278.8430289241305, 6412.294647588855, 6417.679116044085, 6422.967885160544, 6423.42189202974, 6427.100205971261, 6131.570790044832, 6228.03465462854, 6236.6258024518675, 6240.252729235821, 6259.937400626118], "unit": "score", "name": "prototype.html", "value": 4721.028337967717}, {"lowerIsBetter": false, "replicates": [664.3688495928867, 715.7208688611439, 759.8708219602667, 806.4959400374765, 823.4894365493393, 12817.551385701503, 12908.677283067904, 12947.805782913263, 12984.54554090607, 13045.67385815355, 12073.154879158463, 12617.306048167347, 12685.492580296801, 12686.492540298377, 12688.555900543482, 668.3450218785594, 675.3887731602907, 778.9688412463495, 792.4452882981935, 796.4305521552089, 800.967961281548, 802.2899733735657, 808.0989696488432, 808.3331251717327, 808.4623725222749, 828.6892415344246, 840.0507426607925, 842.9241368276854, 843.6920524008754, 843.8143608406141, 696.0916004613977, 704.8907419350008, 825.3108654273659, 839.8614228652265, 840.5839109640706, 616.0789619518848, 618.0975775367968, 618.1068356225256, 618.9845253868644, 621.7544070092288, 12354.691132721664, 12452.0, 12472.251664900135, 12472.251664900135, 12481.687957801038, 11898.940505297505, 12290.139690221687, 12387.256764594153, 12441.75116497665, 12476.126671133025, 10451.529681164366, 10720.517576709066, 10744.0, 10982.615608453745, 11010.174236932262, 3612.584552776438, 3625.3836847735683, 3647.5258216431957, 3817.9427308590393, 3818.9427158592644, 43032.3545146823, 43255.56744432547, 43311.56688433107, 43326.0, 43455.56544434547, 9591.808163836684, 9734.659286924923, 9831.655892043744, 9917.801643967081, 9927.80144397108, 16847.15764211809, 17312.576239326503, 17422.041787701546, 17442.47672569825, 17443.12784360777, 7414.703411863573, 7442.813929651694, 7443.106827180773, 7449.85100297991, 7545.660445279976, 4032.91934161321, 4093.1813637272667, 4204.558521355275, 4308.633766129851, 4311.0, 2992.07245753817, 3001.8949336773544, 3011.5482677598534, 3022.8035177713377, 3026.243439140215, 525.7266221564842, 540.9972950135303, 543.4972650298537, 555.4390066033335, 556.0047514948278, 506.40750322122466, 572.6863471574874, 584.2229834320428, 625.6871564217892, 660.3000819131736, 8170.959145204236, 8411.53736544496, 8469.449485783405, 8705.434146780439, 8725.389222754346, 512.4926322940262, 533.2481201505858, 538.0, 538.9703566303891, 608.0939400293531, 3654.397024490929, 3664.6518580734787, 3867.9226415471535, 3945.230680017369, 4264.914701705949, 53708.46291537034, 55968.44031559714, 59796.70101649464, 59908.0, 64098.35901641017, 46798.53201467942, 48035.75982120067, 48193.277100843516, 49219.753901230266, 49322.0, 44245.0, 44363.778181109534, 44960.3255951161, 45080.77459612746, 45544.54455455403, 8306.792330191553, 8471.237588617054, 8663.306935445024, 8797.604107815292, 8855.97132730376, 33775.49336759902, 33804.0, 34829.12927176739, 34887.82556087305, 34998.82500587481, 39829.62725963948, 40487.190256194124, 44406.3339049908, 44407.77796110999, 45086.0, 10621.522031508446, 10966.725831854268, 11021.173411993972, 11032.724181895517, 11534.826977595176, 12411.255324680547, 12675.619731408073, 12713.55502557406, 13198.472061117447, 13206.867931320949, 10781.353118812896, 10952.616658416917, 10980.505877235704, 11232.101431885267, 11279.605213817476, 9020.548972551478, 9603.519824008632, 11044.944775276394, 11123.666290011313, 11470.541178352772, 10570.577176912837, 10715.946420267848, 10833.187510936868, 10920.890791091988, 11046.0, 9085.545722713705, 9157.587908543997, 9259.72220833376, 9317.767055823659, 9477.573509192242, 8802.29581633455, 9210.263178945803, 9486.33595648298, 9544.379615324982, 9839.508024598885], "unit": "score", "name": "yui.html", "value": 6095.535538879822}], "name": "dromaeo_css", "value": 6778.189251059634}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 112.0, 113.0, 110.0, 101.0, 113.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 151.0, 170.0, 124.0, 152.0, 157.0, 125.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 164.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 85.0, 93.0, 72.0, 71.0, 71.0, 107.0, 90.0, 70.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 139.0, 97.0, 96.0, 96.0, 144.0, 97.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 60.0, 58.0, 56.0, 58.0, 59.0, 57.0, 62.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [93.0, 85.0, 86.0, 86.0, 85.0, 85.0, 86.0, 84.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [116.0, 125.0, 133.0, 116.0, 119.0, 126.0, 125.0, 117.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [154.0, 152.0, 154.0, 157.0, 153.0, 147.0, 154.0, 164.0, 154.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 69.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1511.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1949.317738791423], "unit": "score", "name": "RayTrace", "value": 379.61435700000015}, {"lowerIsBetter": false, "replicates": [796.3404932378679], "unit": "score", "name": "Earley", "value": 836.9070839160837}, {"lowerIsBetter": false, "replicates": [12600.0], "unit": "score", "name": "Boyer", "value": 52.89388888888888}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [673.1283422459893], "unit": "score", "name": "Splay", "value": 121.06309433962264}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19542.588147073293}]} 05:21:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19542.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1511.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6778.19"}}} 05:21:04 INFO - Return code: 0 05:21:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:21:04 INFO - # TBPL SUCCESS # 05:21:04 INFO - Running post-action listener: _resource_record_post_action 05:21:04 INFO - Running post-run listener: _resource_record_post_run 05:21:05 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 383676416; Read time: 0; Write time: 251948 05:21:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 73826304; Read time: 0; Write time: 59496 05:21:05 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 309850112; Read time: 0; Write time: 192452 05:21:05 INFO - Running post-run listener: _upload_blobber_files 05:21:05 INFO - Blob upload gear active. 05:21:05 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:21:05 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:21:05 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:21:05 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:21:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:07 INFO - (blobuploader) - INFO - Done attempting. 05:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:08 INFO - (blobuploader) - INFO - Done attempting. 05:21:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:08 INFO - Return code: 0 05:21:08 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:21:08 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33c61734eab9db91230c642d597b75a098051ce6517a64d1bec90eff9a7c272f15bf3ebcc4042bd50b39e86733c1fa2f89ab0934a9e37daa1f0c756ea1ed06e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00252858dbb2525f0f59aca04dcd40a015eab4fef5162d99fd5e5d955ca1e77764c6a1ef989cd49c7352508979aa78bb53702e06493fb0e6fca6e35cc9460b79"} 05:21:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:21:08 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:21:08 INFO - Contents: 05:21:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33c61734eab9db91230c642d597b75a098051ce6517a64d1bec90eff9a7c272f15bf3ebcc4042bd50b39e86733c1fa2f89ab0934a9e37daa1f0c756ea1ed06e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00252858dbb2525f0f59aca04dcd40a015eab4fef5162d99fd5e5d955ca1e77764c6a1ef989cd49c7352508979aa78bb53702e06493fb0e6fca6e35cc9460b79"} 05:21:08 INFO - Copying logs to upload dir... 05:21:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1301.070332 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-01-05 05:21:07.453592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:07.457684) ========= 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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33c61734eab9db91230c642d597b75a098051ce6517a64d1bec90eff9a7c272f15bf3ebcc4042bd50b39e86733c1fa2f89ab0934a9e37daa1f0c756ea1ed06e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00252858dbb2525f0f59aca04dcd40a015eab4fef5162d99fd5e5d955ca1e77764c6a1ef989cd49c7352508979aa78bb53702e06493fb0e6fca6e35cc9460b79"} build_url:https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33c61734eab9db91230c642d597b75a098051ce6517a64d1bec90eff9a7c272f15bf3ebcc4042bd50b39e86733c1fa2f89ab0934a9e37daa1f0c756ea1ed06e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00252858dbb2525f0f59aca04dcd40a015eab4fef5162d99fd5e5d955ca1e77764c6a1ef989cd49c7352508979aa78bb53702e06493fb0e6fca6e35cc9460b79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:07.485077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:07.485609) ========= 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=ed14279e38b05397cf4aa391000001a4-1451997373.316189-984813565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:07.568713) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 05:21:07.569037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 05:21:07.569340) ========= ========= Total master_lag: 0.25 =========