builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1451998765.0 results: success (0) buildid: 20160105023037 builduid: 99e04f5b654d4a2cb0ceb848f9b11650 revision: 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.002499) ========= 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:25.003112) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.003572) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006308 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.040028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.040309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.076531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.076791) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.039899 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.134158) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.134444) ========= 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:25.134800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.135366) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.6M=0s 2016-01-05 04:59:25 (41.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.338083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.338398) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.115505 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.465228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.465547) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 04:59:25,502 truncating revision to first 12 chars 2016-01-05 04:59:25,502 Setting DEBUG logging. 2016-01-05 04:59:25,503 attempt 1/10 2016-01-05 04:59:25,503 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:25,727 unpacking tar archive at: fx-team-0bea3bcf7946/testing/mozharness/ program finished with exit code 0 elapsedTime=0.497777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.977020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.977402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.987193) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 04:59:25.987484) ========= 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:25.987910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-01-05 04:59:25.988235) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:26 INFO - MultiFileLogger online at 20160105 04:59:26 in /builds/slave/test-pgo 04:59:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:59:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:59:26 INFO - {'append_to_log': False, 04:59:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:59:26 INFO - 'blob_upload_branch': 'Fx-Team', 04:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:59:26 INFO - 'branch': 'Fx-Team', 04:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:26 INFO - 'config_files': ('talos/linux_config.py',), 04:59:26 INFO - 'default_actions': ('clobber', 04:59:26 INFO - 'read-buildbot-config', 04:59:26 INFO - 'download-and-extract', 04:59:26 INFO - 'populate-webroot', 04:59:26 INFO - 'create-virtualenv', 04:59:26 INFO - 'install', 04:59:26 INFO - 'run-tests'), 04:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:26 INFO - 'download_minidump_stackwalk': True, 04:59:26 INFO - 'download_symbols': 'ondemand', 04:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:26 INFO - 'installer_path': 'installer.exe', 04:59:26 INFO - 'log_level': 'info', 04:59:26 INFO - 'log_name': 'talos', 04:59:26 INFO - 'log_to_console': True, 04:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:26 INFO - 'opt_config_files': (), 04:59:26 INFO - 'pip_index': False, 04:59:26 INFO - 'sps_profile': False, 04:59:26 INFO - 'sps_profile_interval': 0, 04:59:26 INFO - 'suite': 'dromaeojs-e10s', 04:59:26 INFO - 'system_bits': '32', 04:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:26 INFO - 'title': 'talos-linux64-ix-005', 04:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:26 INFO - 'use_talos_json': True, 04:59:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:26 INFO - 'work_dir': 'build'} 04:59:26 INFO - ##### 04:59:26 INFO - ##### Running clobber step. 04:59:26 INFO - ##### 04:59:26 INFO - Running pre-action listener: _resource_record_pre_action 04:59:26 INFO - Running main action method: clobber 04:59:26 INFO - rmtree: /builds/slave/test-pgo/build 04:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:59:30 INFO - Running post-action listener: _resource_record_post_action 04:59:30 INFO - ##### 04:59:30 INFO - ##### Running read-buildbot-config step. 04:59:30 INFO - ##### 04:59:30 INFO - Running pre-action listener: _resource_record_pre_action 04:59:30 INFO - Running main action method: read_buildbot_config 04:59:30 INFO - Using buildbot properties: 04:59:30 INFO - { 04:59:30 INFO - "project": "", 04:59:30 INFO - "product": "firefox", 04:59:30 INFO - "script_repo_revision": "production", 04:59:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:59:30 INFO - "repository": "", 04:59:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:59:30 INFO - "buildid": "20160105023037", 04:59:30 INFO - "pgo_build": "True", 04:59:30 INFO - "basedir": "/builds/slave/test-pgo", 04:59:30 INFO - "buildnumber": 424, 04:59:30 INFO - "slavename": "talos-linux64-ix-005", 04:59:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:59:30 INFO - "platform": "ubuntu64_hw", 04:59:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:59:30 INFO - "branch": "fx-team", 04:59:30 INFO - "repo_path": "integration/fx-team", 04:59:30 INFO - "revision": "0bea3bcf7946270ce90bf34cb78827fbdfee2e56", 04:59:30 INFO - "stage_platform": "linux64-pgo", 04:59:30 INFO - "builduid": "99e04f5b654d4a2cb0ceb848f9b11650", 04:59:30 INFO - "slavebuilddir": "test" 04:59:30 INFO - } 04:59:30 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:30 INFO - Running post-action listener: _resource_record_post_action 04:59:30 INFO - ##### 04:59:30 INFO - ##### Running download-and-extract step. 04:59:30 INFO - ##### 04:59:30 INFO - Running pre-action listener: _resource_record_pre_action 04:59:30 INFO - Running main action method: download_and_extract 04:59:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:59: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')]} 04:59:30 INFO - https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json 04:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/test_packages.json 04:59:30 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:30 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 04:59:45 INFO - Downloaded 23199261 bytes. 04:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:59:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:59:46 INFO - Return code: 0 04:59:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:59:46 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:46 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:46 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:46 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:46 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:46 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 04:59:59 INFO - Downloaded 23199261 bytes. 04:59:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:59:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:59:59 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:00 INFO - Return code: 0 05:00:00 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:00 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:00 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:00 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:00 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:00 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:06 INFO - Downloaded 11132285 bytes. 05:00:06 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:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:06 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:17 INFO - Downloaded 54978743 bytes. 05:00:17 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:17 INFO - mkdir: /builds/slave/test-pgo/properties 05:00:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:00:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:00:17 INFO - Contents: 05:00:17 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:17 INFO - Running post-action listener: _resource_record_post_action 05:00:17 INFO - Running post-action listener: set_extra_try_arguments 05:00:17 INFO - ##### 05:00:17 INFO - ##### Running populate-webroot step. 05:00:17 INFO - ##### 05:00:17 INFO - Running pre-action listener: _resource_record_pre_action 05:00:17 INFO - Running main action method: populate_webroot 05:00:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:17 INFO - '--tppagecycles', 05:00:17 INFO - '7'], 05:00:17 INFO - 'tests': ['tsvgm']}}, 05:00:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:00:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:00:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:00:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'tests': ['damp', 'tps']}, 05:00:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['damp', 'tps']}, 05:00:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:00:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:17 INFO - 'other': {'tests': ['a11yr', 05:00:17 INFO - 'ts_paint', 05:00:17 INFO - 'tpaint', 05:00:17 INFO - 'sessionrestore', 05:00:17 INFO - 'sessionrestore_no_auto_restore']}, 05:00:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['a11yr', 05:00:17 INFO - 'ts_paint', 05:00:17 INFO - 'tpaint', 05:00:17 INFO - 'sessionrestore', 05:00:17 INFO - 'sessionrestore_no_auto_restore']}, 05:00:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['a11yr', 05:00:17 INFO - 'ts_paint', 05:00:17 INFO - 'tpaint', 05:00:17 INFO - 'sessionrestore', 05:00:17 INFO - 'sessionrestore_no_auto_restore']}, 05:00:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['a11yr', 05:00:17 INFO - 'ts_paint', 05:00:17 INFO - 'tpaint', 05:00:17 INFO - 'sessionrestore', 05:00:17 INFO - 'sessionrestore_no_auto_restore']}, 05:00:17 INFO - 'other_l64': {'tests': ['a11yr', 05:00:17 INFO - 'ts_paint', 05:00:17 INFO - 'tpaint', 05:00:17 INFO - 'sessionrestore', 05:00:17 INFO - 'sessionrestore_no_auto_restore']}, 05:00:17 INFO - 'other_nol64': {'tests': ['a11yr', 05:00:17 INFO - 'ts_paint', 05:00:17 INFO - 'tpaint', 05:00:17 INFO - 'sessionrestore', 05:00:17 INFO - 'sessionrestore_no_auto_restore']}, 05:00:17 INFO - 'svgr': {'tests': ['tsvgx', 05:00:17 INFO - 'tsvgr_opacity', 05:00:17 INFO - 'tart', 05:00:17 INFO - 'tscrollx', 05:00:17 INFO - 'cart']}, 05:00:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['tsvgx', 05:00:17 INFO - 'tsvgr_opacity', 05:00:17 INFO - 'tart', 05:00:17 INFO - 'tscrollx', 05:00:17 INFO - 'cart']}, 05:00:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'tests': ['tp5o']}, 05:00:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'talos_options': ['--e10s'], 05:00:17 INFO - 'tests': ['tp5o']}, 05:00:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'talos_options': ['--xperf_path', 05:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:17 INFO - 'tests': ['tp5n']}, 05:00:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:17 INFO - 'talos_options': ['--e10s', 05:00:17 INFO - '--xperf_path', 05:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:17 INFO - 'tests': ['tp5n']}}, 05:00:17 INFO - 'talos.zip': {'path': '', 05:00:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:17 INFO - Running post-action listener: _resource_record_post_action 05:00:17 INFO - ##### 05:00:17 INFO - ##### Running create-virtualenv step. 05:00:17 INFO - ##### 05:00:17 INFO - Running pre-action listener: _resource_record_pre_action 05:00:17 INFO - Running main action method: create_virtualenv 05:00:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:00:17 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:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:00:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:17 INFO - Using real prefix '/usr' 05:00:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:00:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:19 INFO - Installing pip.................done. 05:00:19 INFO - Return code: 0 05:00:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 05:00:19 INFO - 'HOME': '/home/cltbld', 05:00:19 INFO - 'LANG': 'en_US.UTF-8', 05:00:19 INFO - 'LANGUAGE': 'en_US:en', 05:00:19 INFO - 'LOGNAME': 'cltbld', 05:00:19 INFO - 'MAIL': '/var/mail/cltbld', 05:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:19 INFO - 'MOZ_NO_REMOTE': '1', 05:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:19 INFO - 'NO_EM_RESTART': '1', 05:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:19 INFO - 'SHELL': '/bin/bash', 05:00:19 INFO - 'SHLVL': '1', 05:00:19 INFO - 'TERM': 'linux', 05:00:19 INFO - 'TMOUT': '86400', 05:00:19 INFO - 'USER': 'cltbld', 05:00:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:19 INFO - '_': '/tools/buildbot/bin/python'} 05:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:19 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:19 INFO - Cleaning up... 05:00:19 INFO - Return code: 0 05:00:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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:19 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:19 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: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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:20 INFO - '_': '/tools/buildbot/bin/python'} 05:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:20 INFO - Downloading/unpacking psutil>=0.7.1 05:00:20 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:20 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 - 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:20 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:20 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:20 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 - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:00:21 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:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:22 INFO - Installing collected packages: psutil 05:00:22 INFO - Running setup.py install for psutil 05:00:22 INFO - building 'psutil._psutil_linux' extension 05:00:22 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:22 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:22 INFO - building 'psutil._psutil_posix' extension 05:00:22 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:22 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:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:22 INFO - Successfully installed psutil 05:00:22 INFO - Cleaning up... 05:00:22 INFO - Return code: 0 05:00:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:00:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:22 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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 05:00:22 INFO - 'HOME': '/home/cltbld', 05:00:22 INFO - 'LANG': 'en_US.UTF-8', 05:00:22 INFO - 'LANGUAGE': 'en_US:en', 05:00:22 INFO - 'LOGNAME': 'cltbld', 05:00:22 INFO - 'MAIL': '/var/mail/cltbld', 05:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:22 INFO - 'MOZ_NO_REMOTE': '1', 05:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:22 INFO - 'NO_EM_RESTART': '1', 05:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:22 INFO - 'SHELL': '/bin/bash', 05:00:22 INFO - 'SHLVL': '1', 05:00:22 INFO - 'TERM': 'linux', 05:00:22 INFO - 'TMOUT': '86400', 05:00:22 INFO - 'USER': 'cltbld', 05:00:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:22 INFO - '_': '/tools/buildbot/bin/python'} 05:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:00:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:24 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:24 INFO - Installing collected packages: mozsystemmonitor 05:00:24 INFO - Running setup.py install for mozsystemmonitor 05:00:24 INFO - Successfully installed mozsystemmonitor 05:00:24 INFO - Cleaning up... 05:00:24 INFO - Return code: 0 05:00:24 INFO - Installing blobuploader==1.2.4 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', '--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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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', '--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:24 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: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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 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 - Downloading/unpacking blobuploader==1.2.4 05:00:24 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:24 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:24 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:24 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:24 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:24 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:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:26 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:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:26 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:26 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:26 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:26 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:26 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:26 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:26 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:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:26 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:26 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:26 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:26 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:26 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:26 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:27 INFO - Downloading docopt-0.6.1.tar.gz 05:00:27 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:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:27 INFO - Running setup.py install for blobuploader 05:00:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:00:27 INFO - Running setup.py install for requests 05:00:27 INFO - Running setup.py install for docopt 05:00:27 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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', '--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:27 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: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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:27 INFO - '_': '/tools/buildbot/bin/python'} 05:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:28 INFO - Running setup.py (path:/tmp/pip-EjYzW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:28 INFO - Running setup.py (path:/tmp/pip-i8lBVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:28 INFO - Running setup.py (path:/tmp/pip-sHyMtv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:28 INFO - Running setup.py (path:/tmp/pip-gA5VRd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:28 INFO - Running setup.py (path:/tmp/pip-yHYjhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:28 INFO - Running setup.py (path:/tmp/pip-1rq6b6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:28 INFO - Running setup.py (path:/tmp/pip-ic6fo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:28 INFO - Running setup.py (path:/tmp/pip-IX6wmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:28 INFO - Running setup.py (path:/tmp/pip-h9eJhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:28 INFO - Running setup.py (path:/tmp/pip-NBf4f8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:28 INFO - Running setup.py (path:/tmp/pip-EEU3wU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:28 INFO - Running setup.py (path:/tmp/pip-M4dJNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:28 INFO - Running setup.py (path:/tmp/pip-YSwowg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:28 INFO - Running setup.py (path:/tmp/pip-iAu0F7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:29 INFO - Running setup.py (path:/tmp/pip-f3TD5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:29 INFO - Running setup.py (path:/tmp/pip-loJg84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:29 INFO - Running setup.py (path:/tmp/pip-hOq7lh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:29 INFO - Running setup.py install for manifestparser 05:00:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:00:29 INFO - Running setup.py install for mozcrash 05:00:29 INFO - Running setup.py install for mozdebug 05:00:29 INFO - Running setup.py install for mozdevice 05:00:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:00:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:00:29 INFO - Running setup.py install for mozfile 05:00:29 INFO - Running setup.py install for mozhttpd 05:00:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:00:29 INFO - Running setup.py install for mozinfo 05:00:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:00:29 INFO - Running setup.py install for mozInstall 05:00:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Running setup.py install for mozleak 05:00:30 INFO - Running setup.py install for mozlog 05:00:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Running setup.py install for moznetwork 05:00:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Running setup.py install for mozprocess 05:00:30 INFO - Running setup.py install for mozprofile 05:00:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Running setup.py install for mozrunner 05:00:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Running setup.py install for mozscreenshot 05:00:30 INFO - Running setup.py install for moztest 05:00:30 INFO - Running setup.py install for mozversion 05:00:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:30 INFO - Cleaning up... 05:00:31 INFO - Return code: 0 05:00:31 INFO - Installing None 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', '-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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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', '-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:31 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: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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 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 - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:31 INFO - Running setup.py (path:/tmp/pip-h7Muzf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:31 INFO - Running setup.py (path:/tmp/pip-_LCdyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:31 INFO - Running setup.py (path:/tmp/pip-8fikUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:31 INFO - Running setup.py (path:/tmp/pip-2a8BT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:31 INFO - Running setup.py (path:/tmp/pip-RBHVxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:31 INFO - Running setup.py (path:/tmp/pip-Fm99Wa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:31 INFO - Running setup.py (path:/tmp/pip-_qzFUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:31 INFO - Running setup.py (path:/tmp/pip-kVMRqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:31 INFO - Running setup.py (path:/tmp/pip-cVcn43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:31 INFO - Running setup.py (path:/tmp/pip-1yZDrQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:31 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:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:31 INFO - Running setup.py (path:/tmp/pip-u3DdKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:32 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:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:32 INFO - Running setup.py (path:/tmp/pip-buZdfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:32 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:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:32 INFO - Running setup.py (path:/tmp/pip-5SprXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:32 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:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:32 INFO - Running setup.py (path:/tmp/pip-L5B4_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:32 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:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:32 INFO - Running setup.py (path:/tmp/pip-Q5bkzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:32 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:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:32 INFO - Running setup.py (path:/tmp/pip-C8bZ97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:32 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:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:32 INFO - Running setup.py (path:/tmp/pip-ivnoPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:34 INFO - Downloading blessings-1.5.1.tar.gz 05:00:34 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:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:34 INFO - Installing collected packages: blessings 05:00:34 INFO - Running setup.py install for blessings 05:00:34 INFO - Successfully installed blessings 05:00:34 INFO - Cleaning up... 05:00:34 INFO - Return code: 0 05:00:34 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:00:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:34 INFO - Reading from file tmpfile_stdout 05:00:34 INFO - Current package versions: 05:00:34 INFO - argparse == 1.2.1 05:00:34 INFO - blessings == 1.5.1 05:00:34 INFO - blobuploader == 1.2.4 05:00:34 INFO - docopt == 0.6.1 05:00:34 INFO - manifestparser == 1.1 05:00:34 INFO - mozInstall == 1.12 05:00:34 INFO - mozcrash == 0.16 05:00:34 INFO - mozdebug == 0.1 05:00:34 INFO - mozdevice == 0.47 05:00:34 INFO - mozfile == 1.2 05:00:34 INFO - mozhttpd == 0.7 05:00:34 INFO - mozinfo == 0.9 05:00:34 INFO - mozleak == 0.1 05:00:34 INFO - mozlog == 3.1 05:00:34 INFO - moznetwork == 0.27 05:00:34 INFO - mozprocess == 0.22 05:00:34 INFO - mozprofile == 0.28 05:00:34 INFO - mozrunner == 6.11 05:00:34 INFO - mozscreenshot == 0.1 05:00:34 INFO - mozsystemmonitor == 0.0 05:00:34 INFO - moztest == 0.7 05:00:34 INFO - mozversion == 1.4 05:00:34 INFO - psutil == 3.1.1 05:00:34 INFO - requests == 1.2.3 05:00:34 INFO - wsgiref == 0.1.2 05:00:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:34 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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 05:00:34 INFO - 'HOME': '/home/cltbld', 05:00:34 INFO - 'LANG': 'en_US.UTF-8', 05:00:34 INFO - 'LANGUAGE': 'en_US:en', 05:00:34 INFO - 'LOGNAME': 'cltbld', 05:00:34 INFO - 'MAIL': '/var/mail/cltbld', 05:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:34 INFO - 'MOZ_NO_REMOTE': '1', 05:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:34 INFO - 'NO_EM_RESTART': '1', 05:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:34 INFO - 'SHELL': '/bin/bash', 05:00:34 INFO - 'SHLVL': '1', 05:00:34 INFO - 'TERM': 'linux', 05:00:34 INFO - 'TMOUT': '86400', 05:00:34 INFO - 'USER': 'cltbld', 05:00:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:34 INFO - '_': '/tools/buildbot/bin/python'} 05:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Cleaning up... 05:00:34 INFO - Return code: 0 05:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:00:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:34 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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 05:00:34 INFO - 'HOME': '/home/cltbld', 05:00:34 INFO - 'LANG': 'en_US.UTF-8', 05:00:34 INFO - 'LANGUAGE': 'en_US:en', 05:00:34 INFO - 'LOGNAME': 'cltbld', 05:00:34 INFO - 'MAIL': '/var/mail/cltbld', 05:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:34 INFO - 'MOZ_NO_REMOTE': '1', 05:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:34 INFO - 'NO_EM_RESTART': '1', 05:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:34 INFO - 'SHELL': '/bin/bash', 05:00:34 INFO - 'SHLVL': '1', 05:00:34 INFO - 'TERM': 'linux', 05:00:34 INFO - 'TMOUT': '86400', 05:00:34 INFO - 'USER': 'cltbld', 05:00:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:34 INFO - '_': '/tools/buildbot/bin/python'} 05:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:34 INFO - Downloading/unpacking jsonschema 05:00:34 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:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:36 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:36 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:36 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:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:36 INFO - warning: no files found matching '*.txt' 05:00:36 INFO - no previously-included directories found matching 'build' 05:00:36 INFO - no previously-included directories found matching 'dist' 05:00:36 INFO - no previously-included directories found matching '.git*' 05:00:36 INFO - Installing collected packages: jsonschema, functools32 05:00:37 INFO - Running setup.py install for functools32 05:00:37 INFO - warning: no files found matching '*.txt' 05:00:37 INFO - no previously-included directories found matching 'build' 05:00:37 INFO - no previously-included directories found matching 'dist' 05:00:37 INFO - no previously-included directories found matching '.git*' 05:00:37 INFO - Successfully installed jsonschema functools32 05:00:37 INFO - Cleaning up... 05:00:37 INFO - Return code: 0 05:00:37 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 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 0x7fc73394af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d72630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 05:00:37 INFO - 'HOME': '/home/cltbld', 05:00:37 INFO - 'LANG': 'en_US.UTF-8', 05:00:37 INFO - 'LANGUAGE': 'en_US:en', 05:00:37 INFO - 'LOGNAME': 'cltbld', 05:00:37 INFO - 'MAIL': '/var/mail/cltbld', 05:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:37 INFO - 'MOZ_NO_REMOTE': '1', 05:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:37 INFO - 'NO_EM_RESTART': '1', 05:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:37 INFO - 'SHELL': '/bin/bash', 05:00:37 INFO - 'SHLVL': '1', 05:00:37 INFO - 'TERM': 'linux', 05:00:37 INFO - 'TMOUT': '86400', 05:00:37 INFO - 'USER': 'cltbld', 05:00:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:37 INFO - '_': '/tools/buildbot/bin/python'} 05:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:37 INFO - Downloading/unpacking flake8 05:00:37 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:37 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:37 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:37 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:37 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:37 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:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:39 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:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:39 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:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:39 INFO - no previously-included directories found matching 'docs/_build' 05:00:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:39 INFO - Running setup.py install for pep8 05:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:39 INFO - no previously-included directories found matching 'docs/_build' 05:00:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:00:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:39 INFO - Cleaning up... 05:00:39 INFO - Return code: 0 05:00:39 INFO - Running post-action listener: _resource_record_post_action 05:00:39 INFO - Running post-action listener: _start_resource_monitoring 05:00:39 INFO - Starting resource monitoring. 05:00:39 INFO - ##### 05:00:39 INFO - ##### Running install step. 05:00:39 INFO - ##### 05:00:39 INFO - Running pre-action listener: _resource_record_pre_action 05:00:39 INFO - Running main action method: install 05:00:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:40 INFO - Reading from file tmpfile_stdout 05:00:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:00:40 INFO - Reading from file tmpfile_stdout 05:00:40 INFO - Output received: 05:00:40 INFO - Usage: mozinstall [options] installer 05:00:40 INFO - Options: 05:00:40 INFO - -h, --help show this help message and exit 05:00:40 INFO - -d DEST, --destination=DEST 05:00:40 INFO - Directory to install application into. [default: 05:00:40 INFO - "/builds/slave/test-pgo"] 05:00:40 INFO - --app=APP Application being installed. [default: firefox] 05:00:40 INFO - mkdir: /builds/slave/test-pgo/build/application 05:00:40 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:40 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:56 INFO - Reading from file tmpfile_stdout 05:00:56 INFO - Output received: 05:00:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:00:56 INFO - Running post-action listener: _resource_record_post_action 05:00:56 INFO - ##### 05:00:56 INFO - ##### Running run-tests step. 05:00:56 INFO - ##### 05:00:56 INFO - Running pre-action listener: _resource_record_pre_action 05:00:56 INFO - Running main action method: run_tests 05:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:00:56 INFO - Python 2.7.3 05:00:56 INFO - Return code: 0 05:00:56 INFO - grabbing minidump binary from tooltool 05:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:56 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 0x1e03840>, '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 0x1d706b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:00:56 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:56 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:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:56 INFO - Return code: 0 05:00:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:00:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:00:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:00:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:00:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:00:57 INFO - Return code: 0 05:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:00:57 INFO - Using env: {'DISPLAY': ':0', 05:00:57 INFO - 'HOME': '/home/cltbld', 05:00:57 INFO - 'LANG': 'en_US.UTF-8', 05:00:57 INFO - 'LANGUAGE': 'en_US:en', 05:00:57 INFO - 'LOGNAME': 'cltbld', 05:00:57 INFO - 'MAIL': '/var/mail/cltbld', 05:00:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:00:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:57 INFO - 'MOZ_NO_REMOTE': '1', 05:00:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:57 INFO - 'NO_EM_RESTART': '1', 05:00:57 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:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:00:57 INFO - 'SHELL': '/bin/bash', 05:00:57 INFO - 'SHLVL': '1', 05:00:57 INFO - 'TERM': 'linux', 05:00:57 INFO - 'TMOUT': '86400', 05:00:57 INFO - 'USER': 'cltbld', 05:00:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423', 05:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:57 INFO - '_': '/tools/buildbot/bin/python'} 05:00:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebxYFWBtTgWOoiMFFKjRjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:00:57 INFO - mozversion application_buildid: 20160105023037 05:00:57 INFO - mozversion application_changeset: 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 05:00:57 INFO - mozversion application_display_name: Nightly 05:00:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:57 INFO - mozversion application_name: Firefox 05:00:57 INFO - mozversion application_remotingname: firefox 05:00:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:00:57 INFO - mozversion application_vendor: Mozilla 05:00:57 INFO - mozversion application_version: 46.0a1 05:00:57 INFO - mozversion platform_buildid: 20160105023037 05:00:57 INFO - mozversion platform_changeset: 0bea3bcf7946270ce90bf34cb78827fbdfee2e56 05:00:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:00:57 INFO - mozversion platform_version: 46.0a1 05:00:57 INFO - using testdate: 1451998857 05:00:57 INFO - actual date: 1451998857 05:00:57 INFO - starting webserver on 'localhost:45119' 05:00:57 INFO - SUITE-START | Running 3 tests 05:00:57 INFO - TEST-START | dromaeo_css 05:00:57 INFO - operating with platform_type : linux_ 05:00:57 INFO - Initialising browser for dromaeo_css test... 05:00:57 INFO - TEST-INFO | started process 12686 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbqLbLf/profile http://localhost:45119/getInfo.html) 05:01:01 INFO - PROCESS | 12686 | __metrics Screen width/height:1600/1200 05:01:01 INFO - PROCESS | 12686 | colorDepth:24 05:01:01 INFO - PROCESS | 12686 | Browser inner width/height: 1024/697 05:01:01 INFO - PROCESS | 12686 | __metrics 05:01:01 INFO - PROCESS | 12686 | 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:01:02 INFO - TEST-INFO | 12686: exit 0 05:01:02 INFO - Browser initialized. 05:01:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:02 INFO - TEST-INFO | started process 12821 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbqLbLf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:14 INFO - PROCESS | 12821 | RSS: Main: 150355968 05:01:14 INFO - PROCESS | 12821 | 05:02:04 INFO - PROCESS | 12821 | 1451998924334 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:13 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:45119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45119/tests/dromaeo/cssquery-ext.html) 05:04:15 INFO - PROCESS | 12821 | RSS: Main: 156962816 05:04:15 INFO - PROCESS | 12821 | 05:07:17 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:45119/tests/dromaeo/cssquery-ext.html (next: http://localhost:45119/tests/dromaeo/cssquery-jquery.html) 05:07:17 INFO - PROCESS | 12821 | RSS: Main: 152100864 05:07:17 INFO - PROCESS | 12821 | 05:10:19 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:45119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45119/tests/dromaeo/cssquery-mootools.html) 05:10:19 INFO - PROCESS | 12821 | RSS: Main: 153001984 05:10:19 INFO - PROCESS | 12821 | 05:13:21 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:45119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45119/tests/dromaeo/cssquery-prototype.html) 05:13:22 INFO - PROCESS | 12821 | RSS: Main: 152285184 05:13:22 INFO - PROCESS | 12821 | 05:16:24 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:45119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45119/tests/dromaeo/cssquery-yui.html) 05:16:25 INFO - PROCESS | 12821 | RSS: Main: 153268224 05:16:25 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:45119/tests/dromaeo/cssquery-yui.html (next: http://localhost:45119/tests/dromaeo/cssquery-dojo.html) 05:19:27 INFO - PROCESS | 12821 | RSS: Main: 154726400 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | __start_tp_report 05:19:27 INFO - PROCESS | 12821 | _x_x_mozilla_page_load 05:19:27 INFO - PROCESS | 12821 | _x_x_mozilla_page_load_details 05:19:27 INFO - PROCESS | 12821 | |i|pagename|runs| 05:19:27 INFO - PROCESS | 12821 | |0;dojo.html;3273.8526766295513;3310.1890036940968;3330.1175188575016;3349.464085746281;3360.529525866379;5347.59893008024;5453.209284653728;5483.040467918113;5483.561315094793;5495.642783219088;5384.219288203209;5470.64440811347;5560.972195139028;5568.192612071247;5585.525230355414;4916.213405855064;4978.875528111799;5003.549680528752;5143.27994080829;5176.404713457944;5097.158968770148;5103.362079740033;5114.335136432259;5129.615278854082;5138;4859.878503037435;4928.852134435972;4939.777710003023;5045.84862454127;5087.847364579032;5028.195488721787;5041.521055499722;5052.21690637948;5066.164082926312;5084.186530155157;4927.236278376858;5012.949870501285;5039.09296326661;5058.822941197041;5071.39143302806;5277.947220527784;5358.812441564526;5394.811181608625;5447.237386765856;5470.972645136789;5894.793682221101;5917.6449413034925;5919.644821310735;5930.822075337746;5933.495652869511;5729.083346664514;5857.502112320458;5948.851278718023;5965.642061476282;5979.641221526722;5441.619086663895;5554.972225138929;5555.027870122753;5569.10894256917;5614.27014488118;6095.634261944298;6118.479929205978;6122.20411346531;6138.570300079041;6139.171211886427;5653.9151912721345;5756.3380211276235;5763.279590051244;5849.415058494116;5878.823635290948;5936.970315148396;5948;5955.3151387590115;5965.821025369246;5989.2812862456785;5851.414858514115;5858.330375842865;5907.32065812437;5920.2895652521975;5924.496417804448;5629.493345598916;5758.856028599319;5791.189233507313;5905.557083218776;5961.761529538857;4547.15877562652;4547.295169248706;4557.248054071041;4561.2473941799235;4587.243104887723;4023.1312659599057;4050.4936882889638;4056.127932494469;4093.815778289984;4128.236276288836;5350.438203988603;5450.04624190765;5462.426445223274;5463.098588732894;5480.725963701799;5741.19623252745;5777.45114214149;5803;5809.535237181015;5926.140709597171;5509.146082357241;5514.91727624086;5553.694546799965;5560;5616.550675945915;5000.424951130593;5021.974890125526;5023.547880690755;5053.444121146671;5085.796568137307;5954.07711804671;6022.668753218615;6141.877162456726;6143.818944274807;6146.569740118238;5962.9105563415715;6026.849328766816;6030.185924900083;6030.668313242813;6039.728212230548;6216.222972128484;6216.378362163748;6217.253929528486;6230.937690623217;6241.625502469867;5667.4615911488345;5797.913031304618;5833.212516310244;5930.229070220844;5946.316173640087;5940.138679891305;5951.018082016419;5973.193618861572;5992.490638295793;6009.338972712911;5824.767009319749;5827.70861456917;5829.446202610745;5839.620424672383;5859.062549991981;5601.04782187021;5697.316322041382;5759.078547432391;5797.826065218051;5841.065429531424;5672.461116193955;5726.856828579319;5732.684702341411;5757.8560535986935;5784.334801497882;5773.942260577341;5781.4218578141845;5782.363939966516;5785.971070144622;5852.18069470283;5508.889822203613;5626.099824028136;5658.575606829422;5697.914531281951;5713.857153571194 05:19:27 INFO - PROCESS | 12821 | |1;ext.html;522.4984015345268;523.3719536556133;531.8244979156877;548.131212028934;552.4806681719186;34135.829320853394;34763.478547821775;34870;34918.650813491855;34933.82533087331;37537.624623753756;38119.04702382435;38207;38431.03922401941;38500.614993850126;8382.832343353144;8623.95688021559;8635.352348573851;8636.093210212932;8640.913590864106;8469.703560375388;8540.060593334729;8588.828223435528;8792.07683193265;8802.119788021211;8729.563521823884;8840.469571825712;8842.159994800484;8851.867221991675;8873.733787986339;8648.481091134552;8663.133686631318;8694.347923905669;8756.605952732143;8764.649414023432;8589.355798315151;8694.913050869536;8737.60680769367;8740.169683880022;8742.475451472932;38066.23867522662;38438.423423648666;38618.42072368917;38640.613593863985;38667;2839.5882597023524;3279.212988882675;3282.097423208637;3291.555639988595;3426.7258619310396;25911.740882591308;25920.351991200183;26611.46777064467;26796.866015669795;26967.46065078707;3647.8176091195332;3657.9817100914593;3666.7433279670436;3707.7404581679293;3836.079340958178;303290;307078;307857;307903;307941;40344.19311613751;52324.476755232725;52992.20511692328;53033.73483132559;53238.73380633072;38551;38683;38763.612363876004;38789.806050969564;38830.41754373687;14054.227017513931;14195.78706319406;14220;14276.14343139415;14293.142411455347;10798.136149108053;10858;10870.510827012804;10872.402017888933;10899.727506812234;13363.933180334036;13395.732085358239;13740.381682824296;13856.792148117785;13879.236641984586;5618.101103823368;5645.576581756384;5712.428757124254;5769.798057067983;5792.9420705793245;919.4713040002025;955.617752898846;1030.5105075089423;1038.4651904269308;1078.3206579854798;27804.72195278021;28084.578731319045;28115;28183.154505364873;28366.71633283682;995.5918073589794;1013.8377859542438;1018.5518371916481;1021.4637315409469;1050.9527071281811;13393.73212535744;13564.93217533906;13808;13926.234057126752;13929.164250145024;374340;380996;382188;382721;384246;49935;50056.49943500591;50265.24602130971;50311;50482;1297.5328881602616;1339.5177736015028;1350.4868150103096;1352.019785655392;1354.627477443691;24983.250502484956;25242;26038.609420858324;26409.867950660122;26503;41065.79467102645;41112.794436028824;41214.58785412108;41466.792666036476;41517.16965660609;286700;286719;286828;288118;289009;30368.69631303747;30799.384012320075;31057.378852423277;31114;31188.844055779577;40048.79975600103;40127.799361004174;40230.1953960925;40359.96727570268;40617.59382406138;29576.556351655174;29857.25356866096;29948.25129371696;37289;37921.81039094787;34528.82735586306;34973.300533989684;35685.82157089198;35900.64099358973;36051.098722532144;33806.49290260697;34683.653163469055;34707.30585388227;34734.30531389308;34962.47556286607;29613.703862961956;31780;31961.200969975936;32605.673943260263;32696.673033270315;24106;24135.75864241335;24174.637380438955;24183.395415114763;24302.635460467754 05:19:27 INFO - PROCESS | 12821 | |2;jquery.html;356.0564504064228;359.27068051854735;361.2035461806717;361.95656521217444;362.9727770417216;13376.59870203893;14077.4369025239;15613.921930390346;17149.485515434524;17642.558936026573;10863.99999999998;10865.239433239676;10903.34579925205;10966.945165274183;10995.780084398308;4852.078105160017;4960.23116416956;4974.97512512437;4975.7263350515705;5243.2135179723155;5338.652987555816;5365.356157261134;5369.892602147955;5388.811391601294;5395.325584301962;5172.19830926207;5329.653572517794;5379.327584051994;5379.757910894019;5398.64908780928;5312.123499622558;5325.334333208349;5332.626716129853;5337.332833395825;5347.224652425377;5051.419086804991;5123.180291153435;5156.1750119981;5275.28783614211;5312.362516498045;12214.694632634166;12355.938220308932;12391.75216495674;14658.70682586353;19245.615087698166;922.861570764384;2106.020700374318;2174.3911704722545;2269.8524595901213;2312.5143719818857;8995.5052472114;9069.183773460354;9076.77308067297;9298.721038368793;9452.480113593749;1708.453294945618;1716.5451155443693;1794.4616615015573;1850.4591513616256;1856.8236017578308;42726.57273427257;62688.68655656738;62811.68594157;62844;63810;10280.434576098236;10313.22650801178;10350.482475876326;10378.740531486774;10395.84406233907;13183.406746696422;13247.801282980763;13268.40292186854;13320.6669833253;13338;7220.494565380373;7394.704211831574;7400.851982960311;7483.775486735407;7541.057367829021;7170.139583250043;7214.278572142849;7242.674079666428;7244.130704315516;7286.198518162998;4346.7609281489185;4428.800703968329;4432.556744325606;4445.844395446144;4485.955140448619;1813.111575328106;1832.1663643042384;1835.6787562176567;1846.2891786662233;1862.6774989757153;404.2053283421599;407.301477965285;907.7140700679265;959.5538074795254;976.3751199232497;10434.947825260826;10785.622503212508;10797.136229101652;10966.122710183166;11007.724806879893;439.14147840970827;448.5626514148679;449.90897074593977;453.3517070589089;456.728246693217;5635.520980716685;5862.560307976919;5870.5890587659305;5905.291365036223;5942.227510423703;526176;532935;543120;547659;549450;77815.61092194503;78676;78960;80228.59885700651;80997.19002810014;474.1915034865546;475.48884948679614;476.5187160967448;477.7109848541652;482.60185347088793;9849.261305402268;9951.15415189717;9958.15355694774;10011.749706257402;10050.396976181453;32691;32923.67076329206;33011;33117.006489805346;33786.662133378355;36777.26445471022;37446;38118.809405952794;38199;40106.39840402338;9046.592903319499;9253.768655783659;9505;9521.333506654744;9536.618535258513;11232.382218978035;11319.207655464368;13487.865121348661;17160.656786863943;17727.113644317473;13950.162990220619;14081.788773168615;14691.779623305445;14699.853001469848;15252.466163684661;13542.59372218835;13953.511627093003;14102.647433814236;14233.217173055582;14308;13956.2324072177;14060.437582496586;14268.21524816145;14915.776263355841;15381.769273460683;9171.724848254564;9539.475328856703;9585.664501742405;9602.231821454407;9828.4102953823;13516.459341626225;13879;14115.858841411455;14676.192809395585;14837.703245934805 05:19:27 INFO - PROCESS | 12821 | |3;mootools.html;1382.3710211853606;1447.5874375802891;1573.32347090751;1743.9825601743978;1768.9115544222786;7575.886361704572;7604.847903041936;7717.575533345678;7742.303192712662;7763.18486558911;7512.586807725573;7513.699452021912;7598.810029749259;7609.277118673731;7612.467127301091;2237.183428048763;2272.4432514034;2272.8522646028036;2274.306336567346;2274.8180145588394;2237.5636750833596;2265.3430505153488;2269.580127676385;2277.2826559633745;2290.0839664134396;2194.8024677779;2200.878951657658;2248.168177774226;2253.7971582557566;2260.175036111824;2197.143114185469;2228.6434170532716;2245.62947113726;2247.831412644042;2259.3109101723967;2218.4675677837363;2231.3863687486073;2233.7877901599486;2235.6870038194666;2245.607018771708;7430.814229644248;7465.85068298631;7535.773926782151;7559.28186822251;7566.394688424913;4480.417545719069;4548.909021819578;4554.4990051094355;4576.8626941191815;4580.3358513015755;2850.230437781808;2920.6495220573665;2950.9114726558237;2959.6004539387122;2978.612780338564;945.3146468810127;952.2762700347716;970.6602689058843;974.133021610767;1012.5392946209457;10429.530671119817;10509.737256568647;10544.209184311207;10598;10646.893531064668;4059.5331536873045;4077.510698716173;4098.098418347959;4146.834126634961;4158.438610787565;8498.447600906045;8588.871166932377;8593.613287401957;8597.613107410181;8648.697295594624;4572.542745725467;4578.5650363215445;4609.976950115228;4614.377059096979;4633.7683115844075;4197.118605092965;4204.747715137101;4232.661387089025;4233.026403927052;4233.70364074518;3338.6828251316088;3351.731861451078;3352.6814952579466;3361.647027062172;3391.932161356759;1017.399734156851;1018.6231094495084;1023.3348323589578;1023.9232057595561;1034.7826956339102;909.9226565741853;969.9466529340813;1074.0655629602295;1132.6318946342471;1301.5249433956537;7040.823979400556;7053.823654408681;7112.537685050455;7129.572225666373;7142.321479459443;1161.0595417711681;1161.2916121166081;1178.6876477733408;1185.3658292813304;1190.1966172833477;5705.372409035002;5751.827445176651;5761.769529218785;5777.942220577825;5797.130430435384;8807;8996;9105.544722763967;9261.583228754722;9293.581788819383;9164.587593558306;9182.403143795633;9216.078392160864;9269.351145419756;9282.90717092834;7229.89155162673;7265.818354541073;7287.380572651278;7287.8339465686295;7372.741954031583;6949.583025018515;6956.965215173892;6965.407940325129;6969.7212111517;6973.65131743421;8117.959410203148;8202.26179643835;8268.958655206685;8337.458065225741;8367;8371.581420929051;8501.787455313666;8523.232909038215;8545.102764209669;8665.653373864974;6462.676866156579;6567.080608714688;6600.768973085919;6735.461163106842;6757.628330441873;7336.559806411632;7345.265473452612;7372.225916278713;7392.112946446461;7397.334239918433;6808.251092379934;6927;6951.0616066830335;7055.435565154673;7055.858882822417;6569.507286953402;6641.667916604247;6752.898706519504;6824.405250001235;6831.077804496329;6546.738130474728;6689.063531105552;6693.631850248283;6709.194896612437;6735.797926062226;6201.441870231521;6217.067439883873;6234.719437625227;6255.56211065221;6278.340774218641;6220.502359811295;6285.528585356025;6286;6347.523935704933;6395.552311338161 05:19:27 INFO - PROCESS | 12821 | |4;prototype.html;325.2227177046858;332.2922175765619;334.83927714696944;335.9428897087495;339.6467673619436;6238.376162383765;6271.404216599416;6283.685815709219;6294.43350098491;6453.548251622388;6189.659568723719;6222.906656400158;6249.625022498653;6272.090546870701;6277.995520716686;4673.462551806551;4687.437507499097;4689.249720044793;4693.084848454553;4702.083093796711;4704.341392205094;4705.458872229703;4705.976470117662;4706.058788242348;4707.576318131368;4500.909981800362;4535;4597.126545956275;4614.907701845961;4657.650676199281;4599.471060828014;4610.124076425485;4614.976925115353;4617.284320930261;4619.214733495281;3990.2817492851277;3993;3994.400839874013;3997.320455522568;4001.6998725095737;5852.180694702745;5918.585699001072;5918.940810591882;5928.525717942554;5931.881362372772;5249.4488078751565;5410.1073322901675;5437.293151890269;5465.398806131322;5465.9180112298345;6538.215414150285;6553.213614366259;6560.179977502812;6583.341665833426;6585.078089067534;4480.865574032784;4498.8425405110665;4499.505054444008;4503.684742068057;4506.121306345264;6756.527043106985;6837.1111755471475;6868.313168683142;6870.866307059379;6914.101166848328;4605.171069207508;4609.953900460952;4610.538946105363;4611.054733779567;4627.213373726475;4661.114388266218;4663.626909847204;4667.719936803803;4671.346011558385;4683.414573178353;5421.647592906448;5422.810201643002;5432.809851655173;5436.619436639477;5440.102383106743;6436.455250739788;6603.7688680895935;6605.603663780189;6620.073189753439;6626.105475760711;1637.6724655069033;1660.2279939827797;1661.8919770214898;1662.8087769906374;1662.9002259864446;1070.5717712914895;1073.758404359013;1077.06833588945;1082.258652822819;1090.3621381491757;6275.6548389839;6285.59143655661;6289.96855015722;6296.622202667854;6302.149209856702;6776.356246156607;6808.829779255559;6819.386255237053;6820.04519367289;6831.9658401707675;6184.226971628546;6262.1859158310035;6295.874082518416;6381.680915954184;6384.616922984543;3704.2591481703766;3719.442083687414;3729.049092481454;3735.364987952055;3762.473253744478;7169.928300716926;7173.964130179315;7184;7201.963990180016;7234.6020968847215;6937.7571784987285;7101.431885449152;7124.92875071253;7132.786016419515;7146.14246290438;7137.179224389158;7165.390941770008;7166.964165179245;7168.569885806868;7169.354758071799;6855.657217139223;6858.348456896587;6868.347506986828;6902.689378977858;6904.861902762017;6616.702248398929;6796.150481189851;6798.898016529657;6805.979103134569;6810.9318906810295;7142.35718785291;7157.785266442015;7189.209186989322;7201.891971620535;7205.027321311556;4574.382458368078;4613.677042606985;4627.907441851076;4631.791569379453;4635.397398338195;6615.66921653925;6834.555753875982;6857.759978400732;6887.104676392037;6917.688704008231;6707.932920670731;6730.831729206809;6737.157855268091;6738.7304507819135;6747;6575.736970521317;6663.600183988976;6673.366030227121;6715.664216789239;6719.731210751711;6578.76974305897;6588.308227636029;6588.670566471753;6591.868162636624;6594.868102637824;6714.630695311805;6727;6728.629925354153;6765.492588055817;6783.084283621648;6430.099786030053;6526.151600291932;6535.509836762167;6564.212294524687;6570.737170513317 05:19:27 INFO - PROCESS | 12821 | |5;yui.html;729.3800269770695;754.2269174096552;759.3279947246685;787.5432249295405;852.8848605438268;15133.47032853849;15157.469488567902;15168;15174.393024279016;15212.23938803061;13084.803727944089;13181.60455186346;13194.604161875135;13203;13221.669458263548;790.695582200851;795.3597354129923;807.0718673525434;808.6805711743858;809.4374409785202;799.3365506629484;800.8358286551272;804.7103042904549;806.9152738962413;808.6078252047752;836.9874451883227;837.9622916968721;841.0706169682504;841.2302742990187;843.5613480989881;827.0695467598952;828.3745771942146;828.5401602110826;831.1854382704983;835.5822088955522;608.4888693497439;615.0927382111395;615.0988801405917;616.8457885528618;618.9721462534196;13261.3369331534;13268.535601254007;13301;13386.062975591713;13422.127561708458;12217;12688.49246030167;12875.935620321932;12930.159539629894;13135.86864131356;9767.365121267096;10471.476426178737;10846.620368287073;11193.16051296156;11244.606438774685;3673.1000904778234;3690.9815450922843;3691.667749902522;3793.013816407754;3819.5034645495907;45375.546244537465;46417.30374044426;46470;46594.30108548375;47490;9622.230221582256;9815.75460613476;10027.448490333101;10194.694159175237;10214.285000050073;18167.27330906749;18175.09124543794;18180.45458636243;18208.726869096976;18229.54426139357;7407;7483.289087536676;7598.240175982468;7730.304272615492;7769.53382797034;4155.1897380010605;4161;4192;4193.748375097504;4234.428352172417;3011.1869795155185;3019.3961207758534;3025.213444504445;3026.0770465008386;3026.4703676856902;535.9062164121264;557.5511713071016;562.5190462154799;570.5578176912926;573.4666759913321;485.7911098227725;509.17005281391096;591.721890711365;625.8967270400333;662.2384258103124;8085.272325490734;8222.547759873265;8357.331413486907;8439.324854011664;8470.717459683483;526.3000209721062;537.8386484054846;565.251042368863;593.664579512574;619.4641634985705;4182;4202.957970420318;4245.660347172219;4271.444712187458;4414.183376075436;51857.7407112962;52517.89928402821;53159.73420132875;53335.46664533305;53411.19883201755;46975.765121174176;48341.274880876816;49536.75231623819;49638.75180624074;50303.496965030616;42770.14459710789;44061;44598.77700611476;45083;45269.32096018562;8270.83458330818;8388;8916.821663566821;8972.147645973622;8988.325875559229;33423.33153336968;33838.66161338355;33847.49228761521;34058.65941340555;34131;39226;41743.7912810434;42400;42905.785471073694;43000.56999429966;11102.500387482422;11125.332480051224;11239.775204495701;11418.486168122288;11458.82811757841;11194.272372295774;11224.775504490028;11245.943770281096;11665.416729163338;11770.411479426166;11095.500702468247;11336.489857956576;11388.202825802115;11564.653060408202;11650.88349116498;11459.389278669763;11576.594819181288;11788.351640659846;11894.286342819458;12057.276563406223;10239.078482936273;10752;10762.192835537522;10886.891131088587;11009.119270458184;9277.536123193948;9366.415905159241;9428.340016199074;9477.336586438883;9613.567389467351;8415.45299555527;8627.525486098324;8838;9293.210077143249;9538.332316737762 05:19:27 INFO - PROCESS | 12821 | __end_tp_report 05:19:27 INFO - PROCESS | 12821 | __start_cc_report 05:19:27 INFO - PROCESS | 12821 | _x_x_mozilla_cycle_collect,308 05:19:27 INFO - PROCESS | 12821 | __end_cc_report 05:19:27 INFO - PROCESS | 12821 | __startTimestamp1451999967905__endTimestamp 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | ------- Summary: start ------- 05:19:27 INFO - PROCESS | 12821 | Number of tests: 6 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | [#0] dojo.html Cycles:165 Average:5489.91 Median:5672.46 stddev:610.40 (10.8%) stddev-sans-first:586.99 05:19:27 INFO - PROCESS | 12821 | Values: 3273.9 3310.2 3330.1 3349.5 3360.5 5347.6 5453.2 5483.0 5483.6 5495.6 5384.2 5470.6 5561.0 5568.2 5585.5 4916.2 4978.9 5003.5 5143.3 5176.4 5097.2 5103.4 5114.3 5129.6 5138.0 4859.9 4928.9 4939.8 5045.8 5087.8 5028.2 5041.5 5052.2 5066.2 5084.2 4927.2 5012.9 5039.1 5058.8 5071.4 5277.9 5358.8 5394.8 5447.2 5471.0 5894.8 5917.6 5919.6 5930.8 5933.5 5729.1 5857.5 5948.9 5965.6 5979.6 5441.6 5555.0 5555.0 5569.1 5614.3 6095.6 6118.5 6122.2 6138.6 6139.2 5653.9 5756.3 5763.3 5849.4 5878.8 5937.0 5948.0 5955.3 5965.8 5989.3 5851.4 5858.3 5907.3 5920.3 5924.5 5629.5 5758.9 5791.2 5905.6 5961.8 4547.2 4547.3 4557.2 4561.2 4587.2 4023.1 4050.5 4056.1 4093.8 4128.2 5350.4 5450.0 5462.4 5463.1 5480.7 5741.2 5777.5 5803.0 5809.5 5926.1 5509.1 5514.9 5553.7 5560.0 5616.6 5000.4 5022.0 5023.5 5053.4 5085.8 5954.1 6022.7 6141.9 6143.8 6146.6 5962.9 6026.8 6030.2 6030.7 6039.7 6216.2 6216.4 6217.3 6230.9 6241.6 5667.5 5797.9 5833.2 5930.2 5946.3 5940.1 5951.0 5973.2 5992.5 6009.3 5824.8 5827.7 5829.4 5839.6 5859.1 5601.0 5697.3 5759.1 5797.8 5841.1 5672.5 5726.9 5732.7 5757.9 5784.3 5773.9 5781.4 5782.4 5786.0 5852.2 5508.9 5626.1 5658.6 5697.9 5713.9 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | [#1] ext.html Cycles:180 Average:46944.14 Median:34967.89 stddev:86195.68 (246.5%) stddev-sans-first:86367.01 05:19:27 INFO - PROCESS | 12821 | Values: 522.5 523.4 531.8 548.1 552.5 34135.8 34763.5 34870.0 34918.7 34933.8 37537.6 38119.0 38207.0 38431.0 38500.6 8382.8 8624.0 8635.4 8636.1 8640.9 8469.7 8540.1 8588.8 8792.1 8802.1 8729.6 8840.5 8842.2 8851.9 8873.7 8648.5 8663.1 8694.3 8756.6 8764.6 8589.4 8694.9 8737.6 8740.2 8742.5 38066.2 38438.4 38618.4 38640.6 38667.0 2839.6 3279.2 3282.1 3291.6 3426.7 25911.7 25920.4 26611.5 26796.9 26967.5 3647.8 3658.0 3666.7 3707.7 3836.1 303290.0 307078.0 307857.0 307903.0 307941.0 40344.2 52324.5 52992.2 53033.7 53238.7 38551.0 38683.0 38763.6 38789.8 38830.4 14054.2 14195.8 14220.0 14276.1 14293.1 10798.1 10858.0 10870.5 10872.4 10899.7 13363.9 13395.7 13740.4 13856.8 13879.2 5618.1 5645.6 5712.4 5769.8 5792.9 919.5 955.6 1030.5 1038.5 1078.3 27804.7 28084.6 28115.0 28183.2 28366.7 995.6 1013.8 1018.6 1021.5 1051.0 13393.7 13564.9 13808.0 13926.2 13929.2 374340.0 380996.0 382188.0 382721.0 384246.0 49935.0 50056.5 50265.2 50311.0 50482.0 1297.5 1339.5 1350.5 1352.0 1354.6 24983.3 25242.0 26038.6 26409.9 26503.0 41065.8 41112.8 41214.6 41466.8 41517.2 286700.0 286719.0 286828.0 288118.0 289009.0 30368.7 30799.4 31057.4 31114.0 31188.8 40048.8 40127.8 40230.2 40360.0 40617.6 29576.6 29857.3 29948.3 37289.0 37921.8 34528.8 34973.3 35685.8 35900.6 36051.1 33806.5 34683.7 34707.3 34734.3 34962.5 29613.7 31780.0 31961.2 32605.7 32696.7 24106.0 24135.8 24174.6 24183.4 24302.6 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | [#2] jquery.html Cycles:180 Average:27576.47 Median:2433.97 stddev:88315.61 (3628.5%) stddev-sans-first:88539.71 05:19:27 INFO - PROCESS | 12821 | Values: 356.1 359.3 361.2 362.0 363.0 13376.6 14077.4 15613.9 17149.5 17642.6 10864.0 10865.2 10903.3 10966.9 10995.8 4852.1 4960.2 4975.0 4975.7 5243.2 5338.7 5365.4 5369.9 5388.8 5395.3 5172.2 5329.7 5379.3 5379.8 5398.6 5312.1 5325.3 5332.6 5337.3 5347.2 5051.4 5123.2 5156.2 5275.3 5312.4 12214.7 12355.9 12391.8 14658.7 19245.6 922.9 2106.0 2174.4 2269.9 2312.5 8995.5 9069.2 9076.8 9298.7 9452.5 1708.5 1716.5 1794.5 1850.5 1856.8 42726.6 62688.7 62811.7 62844.0 63810.0 10280.4 10313.2 10350.5 10378.7 10395.8 13183.4 13247.8 13268.4 13320.7 13338.0 7220.5 7394.7 7400.9 7483.8 7541.1 7170.1 7214.3 7242.7 7244.1 7286.2 4346.8 4428.8 4432.6 4445.8 4486.0 1813.1 1832.2 1835.7 1846.3 1862.7 404.2 407.3 907.7 959.6 976.4 10434.9 10785.6 10797.1 10966.1 11007.7 439.1 448.6 449.9 453.4 456.7 5635.5 5862.6 5870.6 5905.3 5942.2 526176.0 532935.0 543120.0 547659.0 549450.0 77815.6 78676.0 78960.0 80228.6 80997.2 474.2 475.5 476.5 477.7 482.6 9849.3 9951.2 9958.2 10011.7 10050.4 32691.0 32923.7 33011.0 33117.0 33786.7 36777.3 37446.0 38118.8 38199.0 40106.4 9046.6 9253.8 9505.0 9521.3 9536.6 11232.4 11319.2 13487.9 17160.7 17727.1 13950.2 14081.8 14691.8 14699.9 15252.5 13542.6 13953.5 14102.6 14233.2 14308.0 13956.2 14060.4 14268.2 14915.8 15381.8 9171.7 9539.5 9585.7 9602.2 9828.4 13516.5 13879.0 14115.9 14676.2 14837.7 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | [#3] mootools.html Cycles:180 Average:5328.51 Median:6285.76 stddev:2762.10 (43.9%) stddev-sans-first:2753.92 05:19:27 INFO - PROCESS | 12821 | Values: 1382.4 1447.6 1573.3 1744.0 1768.9 7575.9 7604.8 7717.6 7742.3 7763.2 7512.6 7513.7 7598.8 7609.3 7612.5 2237.2 2272.4 2272.9 2274.3 2274.8 2237.6 2265.3 2269.6 2277.3 2290.1 2194.8 2200.9 2248.2 2253.8 2260.2 2197.1 2228.6 2245.6 2247.8 2259.3 2218.5 2231.4 2233.8 2235.7 2245.6 7430.8 7465.9 7535.8 7559.3 7566.4 4480.4 4548.9 4554.5 4576.9 4580.3 2850.2 2920.6 2950.9 2959.6 2978.6 945.3 952.3 970.7 974.1 1012.5 10429.5 10509.7 10544.2 10598.0 10646.9 4059.5 4077.5 4098.1 4146.8 4158.4 8498.4 8588.9 8593.6 8597.6 8648.7 4572.5 4578.6 4610.0 4614.4 4633.8 4197.1 4204.7 4232.7 4233.0 4233.7 3338.7 3351.7 3352.7 3361.6 3391.9 1017.4 1018.6 1023.3 1023.9 1034.8 909.9 969.9 1074.1 1132.6 1301.5 7040.8 7053.8 7112.5 7129.6 7142.3 1161.1 1161.3 1178.7 1185.4 1190.2 5705.4 5751.8 5761.8 5777.9 5797.1 8807.0 8996.0 9105.5 9261.6 9293.6 9164.6 9182.4 9216.1 9269.4 9282.9 7229.9 7265.8 7287.4 7287.8 7372.7 6949.6 6957.0 6965.4 6969.7 6973.7 8118.0 8202.3 8269.0 8337.5 8367.0 8371.6 8501.8 8523.2 8545.1 8665.7 6462.7 6567.1 6600.8 6735.5 6757.6 7336.6 7345.3 7372.2 7392.1 7397.3 6808.3 6927.0 6951.1 7055.4 7055.9 6569.5 6641.7 6752.9 6824.4 6831.1 6546.7 6689.1 6693.6 6709.2 6735.8 6201.4 6217.1 6234.7 6255.6 6278.3 6220.5 6285.5 6286.0 6347.5 6395.6 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | [#4] prototype.html Cycles:180 Average:5522.78 Median:6284.64 stddev:1704.49 (27.1%) stddev-sans-first:1664.03 05:19:27 INFO - PROCESS | 12821 | Values: 325.2 332.3 334.8 335.9 339.6 6238.4 6271.4 6283.7 6294.4 6453.5 6189.7 6222.9 6249.6 6272.1 6278.0 4673.5 4687.4 4689.2 4693.1 4702.1 4704.3 4705.5 4706.0 4706.1 4707.6 4500.9 4535.0 4597.1 4614.9 4657.7 4599.5 4610.1 4615.0 4617.3 4619.2 3990.3 3993.0 3994.4 3997.3 4001.7 5852.2 5918.6 5918.9 5928.5 5931.9 5249.4 5410.1 5437.3 5465.4 5465.9 6538.2 6553.2 6560.2 6583.3 6585.1 4480.9 4498.8 4499.5 4503.7 4506.1 6756.5 6837.1 6868.3 6870.9 6914.1 4605.2 4610.0 4610.5 4611.1 4627.2 4661.1 4663.6 4667.7 4671.3 4683.4 5421.6 5422.8 5432.8 5436.6 5440.1 6436.5 6603.8 6605.6 6620.1 6626.1 1637.7 1660.2 1661.9 1662.8 1662.9 1070.6 1073.8 1077.1 1082.3 1090.4 6275.7 6285.6 6290.0 6296.6 6302.1 6776.4 6808.8 6819.4 6820.0 6832.0 6184.2 6262.2 6295.9 6381.7 6384.6 3704.3 3719.4 3729.0 3735.4 3762.5 7169.9 7174.0 7184.0 7202.0 7234.6 6937.8 7101.4 7124.9 7132.8 7146.1 7137.2 7165.4 7167.0 7168.6 7169.4 6855.7 6858.3 6868.3 6902.7 6904.9 6616.7 6796.2 6798.9 6806.0 6810.9 7142.4 7157.8 7189.2 7201.9 7205.0 4574.4 4613.7 4627.9 4631.8 4635.4 6615.7 6834.6 6857.8 6887.1 6917.7 6707.9 6730.8 6737.2 6738.7 6747.0 6575.7 6663.6 6673.4 6715.7 6719.7 6578.8 6588.3 6588.7 6591.9 6594.9 6714.6 6727.0 6728.6 6765.5 6783.1 6430.1 6526.2 6535.5 6564.2 6570.7 05:19:27 INFO - PROCESS | 12821 | 05:19:27 INFO - PROCESS | 12821 | [#5] yui.html Cycles:180 Average:13411.83 Median:45176.16 stddev:15052.83 (33.3%) stddev-sans-first:15064.93 05:19:27 INFO - PROCESS | 12821 | Values: 729.4 754.2 759.3 787.5 852.9 15133.5 15157.5 15168.0 15174.4 15212.2 13084.8 13181.6 13194.6 13203.0 13221.7 790.7 795.4 807.1 808.7 809.4 799.3 800.8 804.7 806.9 808.6 837.0 838.0 841.1 841.2 843.6 827.1 828.4 828.5 831.2 835.6 608.5 615.1 615.1 616.8 619.0 13261.3 13268.5 13301.0 13386.1 13422.1 12217.0 12688.5 12875.9 12930.2 13135.9 9767.4 10471.5 10846.6 11193.2 11244.6 3673.1 3691.0 3691.7 3793.0 3819.5 45375.5 46417.3 46470.0 46594.3 47490.0 9622.2 9815.8 10027.4 10194.7 10214.3 18167.3 18175.1 18180.5 18208.7 18229.5 7407.0 7483.3 7598.2 7730.3 7769.5 4155.2 4161.0 4192.0 4193.7 4234.4 3011.2 3019.4 3025.2 3026.1 3026.5 535.9 557.6 562.5 570.6 573.5 485.8 509.2 591.7 625.9 662.2 8085.3 8222.5 8357.3 8439.3 8470.7 526.3 537.8 565.3 593.7 619.5 4182.0 4203.0 4245.7 4271.4 4414.2 51857.7 52517.9 53159.7 53335.5 53411.2 46975.8 48341.3 49536.8 49638.8 50303.5 42770.1 44061.0 44598.8 45083.0 45269.3 8270.8 8388.0 8916.8 8972.1 8988.3 33423.3 33838.7 33847.5 34058.7 34131.0 39226.0 41743.8 42400.0 42905.8 43000.6 11102.5 11125.3 11239.8 11418.5 11458.8 11194.3 11224.8 11245.9 11665.4 11770.4 11095.5 11336.5 11388.2 11564.7 11650.9 11459.4 11576.6 11788.4 11894.3 12057.3 10239.1 10752.0 10762.2 10886.9 11009.1 9277.5 9366.4 9428.3 9477.3 9613.6 8415.5 8627.5 8838.0 9293.2 9538.3 05:19:27 INFO - PROCESS | 12821 | -------- Summary: end -------- 05:19:27 INFO - PROCESS | 12821 | 05:19:28 INFO - TEST-INFO | 12821: exit 0 05:19:28 INFO - TEST-OK | dromaeo_css | took 1111311ms 05:19:28 INFO - TEST-START | kraken 05:19:28 INFO - operating with platform_type : linux_ 05:19:28 INFO - Initialising browser for kraken test... 05:19:28 INFO - TEST-INFO | started process 13062 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCvbVo6/profile http://localhost:45119/getInfo.html) 05:19:32 INFO - PROCESS | 13062 | __metrics Screen width/height:1600/1200 05:19:32 INFO - PROCESS | 13062 | colorDepth:24 05:19:32 INFO - PROCESS | 13062 | Browser inner width/height: 1024/697 05:19:32 INFO - PROCESS | 13062 | __metrics 05:19:32 INFO - PROCESS | 13062 | 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:33 INFO - TEST-INFO | 13062: exit 0 05:19:33 INFO - Browser initialized. 05:19:33 INFO - Running cycle 1/1 for kraken test... 05:19:33 INFO - TEST-INFO | started process 13184 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCvbVo6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:45 INFO - PROCESS | 13184 | RSS: Main: 151101440 05:19:45 INFO - PROCESS | 13184 | 05:19:48 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45119/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:48 INFO - PROCESS | 13184 | RSS: Main: 151633920 05:19:48 INFO - PROCESS | 13184 | 05:19:51 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45119/tests/kraken/driver.html?testName=audio-dft) 05:19:52 INFO - PROCESS | 13184 | RSS: Main: 152145920 05:19:52 INFO - PROCESS | 13184 | 05:19:54 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45119/tests/kraken/driver.html?testName=audio-fft) 05:19:55 INFO - PROCESS | 13184 | RSS: Main: 147120128 05:19:55 INFO - PROCESS | 13184 | 05:19:57 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45119/tests/kraken/driver.html?testName=audio-oscillator) 05:19:58 INFO - PROCESS | 13184 | RSS: Main: 146587648 05:19:58 INFO - PROCESS | 13184 | 05:20:00 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:01 INFO - PROCESS | 13184 | RSS: Main: 146952192 05:20:01 INFO - PROCESS | 13184 | 05:20:04 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45119/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:04 INFO - PROCESS | 13184 | RSS: Main: 148029440 05:20:04 INFO - PROCESS | 13184 | 05:20:08 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45119/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:08 INFO - PROCESS | 13184 | RSS: Main: 149123072 05:20:08 INFO - PROCESS | 13184 | 05:20:11 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45119/tests/kraken/driver.html?testName=json-parse-financial) 05:20:12 INFO - PROCESS | 13184 | RSS: Main: 148684800 05:20:12 INFO - PROCESS | 13184 | 05:20:13 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:14 INFO - PROCESS | 13184 | RSS: Main: 148918272 05:20:14 INFO - PROCESS | 13184 | 05:20:15 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:16 INFO - PROCESS | 13184 | RSS: Main: 148979712 05:20:16 INFO - PROCESS | 13184 | 05:20:18 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:19 INFO - PROCESS | 13184 | RSS: Main: 149172224 05:20:19 INFO - PROCESS | 13184 | 05:20:21 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:22 INFO - PROCESS | 13184 | RSS: Main: 149159936 05:20:22 INFO - PROCESS | 13184 | 05:20:24 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:25 INFO - PROCESS | 13184 | RSS: Main: 149090304 05:20:25 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:45119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45119/tests/kraken/driver.html?testName=ai-astar) 05:20:27 INFO - PROCESS | 13184 | RSS: Main: 150118400 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | __start_tp_report 05:20:27 INFO - PROCESS | 13184 | _x_x_mozilla_page_load 05:20:27 INFO - PROCESS | 13184 | _x_x_mozilla_page_load_details 05:20:27 INFO - PROCESS | 13184 | |i|pagename|runs| 05:20:27 INFO - PROCESS | 13184 | |0;ai-astar;112;106;113;111;112;123;111;111;112;111 05:20:27 INFO - PROCESS | 13184 | |1;audio-beat-detection;155;127;158;158;133;157;150;129;161;131 05:20:27 INFO - PROCESS | 13184 | |2;audio-dft;164;165;162;162;161;163;163;169;167;163 05:20:27 INFO - PROCESS | 13184 | |3;audio-fft;72;72;75;73;71;71;71;129;71;71 05:20:27 INFO - PROCESS | 13184 | |4;audio-oscillator;96;96;145;95;96;96;146;97;97;134 05:20:27 INFO - PROCESS | 13184 | |5;imaging-gaussian-blur;110;110;110;111;111;110;110;110;111;109 05:20:27 INFO - PROCESS | 13184 | |6;imaging-darkroom;147;148;147;147;146;147;146;148;148;147 05:20:27 INFO - PROCESS | 13184 | |7;imaging-desaturate;97;97;96;96;98;96;96;96;96;96 05:20:27 INFO - PROCESS | 13184 | |8;json-parse-financial;59;60;59;57;59;58;66;57;55;56 05:20:27 INFO - PROCESS | 13184 | |9;json-stringify-tinderbox;67;68;67;67;67;68;68;67;67;68 05:20:27 INFO - PROCESS | 13184 | |10;stanford-crypto-aes;85;86;87;85;87;94;87;88;86;87 05:20:27 INFO - PROCESS | 13184 | |11;stanford-crypto-ccm;129;121;118;120;129;128;120;127;125;126 05:20:27 INFO - PROCESS | 13184 | |12;stanford-crypto-pbkdf2;143;159;153;152;157;142;151;151;153;146 05:20:27 INFO - PROCESS | 13184 | |13;stanford-crypto-sha256-iterative;69;69;70;69;74;70;70;69;69;70 05:20:27 INFO - PROCESS | 13184 | __end_tp_report 05:20:27 INFO - PROCESS | 13184 | __start_cc_report 05:20:27 INFO - PROCESS | 13184 | _x_x_mozilla_cycle_collect,740 05:20:27 INFO - PROCESS | 13184 | __end_cc_report 05:20:27 INFO - PROCESS | 13184 | __startTimestamp1452000027500__endTimestamp 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | ------- Summary: start ------- 05:20:27 INFO - PROCESS | 13184 | Number of tests: 14 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.24 (3.8%) stddev-sans-first:4.49 05:20:27 INFO - PROCESS | 13184 | Values: 112.0 106.0 113.0 111.0 112.0 123.0 111.0 111.0 112.0 111.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:156.00 stddev:14.04 (9.0%) stddev-sans-first:14.50 05:20:27 INFO - PROCESS | 13184 | Values: 155.0 127.0 158.0 158.0 133.0 157.0 150.0 129.0 161.0 131.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.47 (1.5%) stddev-sans-first:2.62 05:20:27 INFO - PROCESS | 13184 | Values: 164.0 165.0 162.0 162.0 161.0 163.0 163.0 169.0 167.0 163.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#3] audio-fft Cycles:10 Average:77.60 Median:71.50 stddev:18.11 (25.3%) stddev-sans-first:19.09 05:20:27 INFO - PROCESS | 13184 | Values: 72.0 72.0 75.0 73.0 71.0 71.0 71.0 129.0 71.0 71.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.22 (23.1%) stddev-sans-first:23.00 05:20:27 INFO - PROCESS | 13184 | Values: 96.0 96.0 145.0 95.0 96.0 96.0 146.0 97.0 97.0 134.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 05:20:27 INFO - PROCESS | 13184 | Values: 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 111.0 109.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:20:27 INFO - PROCESS | 13184 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 146.0 148.0 148.0 147.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:20:27 INFO - PROCESS | 13184 | Values: 97.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:3.03 (5.1%) stddev-sans-first:3.21 05:20:27 INFO - PROCESS | 13184 | Values: 59.0 60.0 59.0 57.0 59.0 58.0 66.0 57.0 55.0 56.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:20:27 INFO - PROCESS | 13184 | Values: 67.0 68.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 68.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:2.57 (3.0%) stddev-sans-first:2.60 05:20:27 INFO - PROCESS | 13184 | Values: 85.0 86.0 87.0 85.0 87.0 94.0 87.0 88.0 86.0 87.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:126.50 stddev:4.16 (3.3%) stddev-sans-first:4.06 05:20:27 INFO - PROCESS | 13184 | Values: 129.0 121.0 118.0 120.0 129.0 128.0 120.0 127.0 125.0 126.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:152.50 stddev:5.56 (3.6%) stddev-sans-first:5.15 05:20:27 INFO - PROCESS | 13184 | Values: 143.0 159.0 153.0 152.0 157.0 142.0 151.0 151.0 153.0 146.0 05:20:27 INFO - PROCESS | 13184 | 05:20:27 INFO - PROCESS | 13184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.52 (2.2%) stddev-sans-first:1.58 05:20:27 INFO - PROCESS | 13184 | Values: 69.0 69.0 70.0 69.0 74.0 70.0 70.0 69.0 69.0 70.0 05:20:27 INFO - PROCESS | 13184 | -------- Summary: end -------- 05:20:27 INFO - PROCESS | 13184 | 05:20:28 INFO - TEST-INFO | 13184: exit 0 05:20:28 INFO - TEST-OK | kraken | took 59914ms 05:20:28 INFO - TEST-START | v8_7 05:20:28 INFO - operating with platform_type : linux_ 05:20:28 INFO - Initialising browser for v8_7 test... 05:20:28 INFO - TEST-INFO | started process 13473 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp67e13L/profile http://localhost:45119/getInfo.html) 05:20:32 INFO - PROCESS | 13473 | __metrics Screen width/height:1600/1200 05:20:32 INFO - PROCESS | 13473 | colorDepth:24 05:20:32 INFO - PROCESS | 13473 | Browser inner width/height: 1024/697 05:20:32 INFO - PROCESS | 13473 | __metrics 05:20:32 INFO - PROCESS | 13473 | 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:33 INFO - TEST-INFO | 13473: exit 0 05:20:33 INFO - Browser initialized. 05:20:33 INFO - Running cycle 1/1 for v8_7 test... 05:20:33 INFO - TEST-INFO | started process 13594 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp67e13L/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:45 INFO - PROCESS | 13594 | RSS: Main: 150769664 05:20:45 INFO - PROCESS | 13594 | 05:21:06 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:45119/tests/v8_7/run.html (next: http://localhost:45119/tests/v8_7/run.html) 05:21:07 INFO - PROCESS | 13594 | RSS: Main: 147173376 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | __start_tp_report 05:21:07 INFO - PROCESS | 13594 | _x_x_mozilla_page_load 05:21:07 INFO - PROCESS | 13594 | _x_x_mozilla_page_load_details 05:21:07 INFO - PROCESS | 13594 | |i|pagename|runs| 05:21:07 INFO - PROCESS | 13594 | |0;Richards;165.89250165892503 05:21:07 INFO - PROCESS | 13594 | |1;DeltaBlue;189.53752843062927 05:21:07 INFO - PROCESS | 13594 | |2;Encrypt;279.17364600781684 05:21:07 INFO - PROCESS | 13594 | |3;Decrypt;5164.948453608247 05:21:07 INFO - PROCESS | 13594 | |4;RayTrace;1069.51871657754 05:21:07 INFO - PROCESS | 13594 | |5;Earley;719.9424046076314 05:21:07 INFO - PROCESS | 13594 | |6;Boyer;12207.317073170732 05:21:07 INFO - PROCESS | 13594 | |7;RegExp;24951.219512195123 05:21:07 INFO - PROCESS | 13594 | |8;Splay;823.7232289950576 05:21:07 INFO - PROCESS | 13594 | |9;NavierStokes;4845.410628019324 05:21:07 INFO - PROCESS | 13594 | __end_tp_report 05:21:07 INFO - PROCESS | 13594 | __startTimestamp1452000067148__endTimestamp 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | ------- Summary: start ------- 05:21:07 INFO - PROCESS | 13594 | Number of tests: 10 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 165.9 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#1] DeltaBlue Cycles:1 Average:189.54 Median:189.54 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 189.5 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 279.2 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 5164.9 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 1069.5 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#5] Earley Cycles:1 Average:719.94 Median:719.94 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 719.9 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 12207.3 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#7] RegExp Cycles:1 Average:24951.22 Median:24951.22 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 24951.2 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#8] Splay Cycles:1 Average:823.72 Median:823.72 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 823.7 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - PROCESS | 13594 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:21:07 INFO - PROCESS | 13594 | Values: 4845.4 05:21:07 INFO - PROCESS | 13594 | -------- Summary: end -------- 05:21:07 INFO - PROCESS | 13594 | 05:21:07 INFO - TEST-INFO | 13594: exit 0 05:21:08 INFO - TEST-OK | v8_7 | took 39431ms 05:21:08 INFO - SUITE-END | took 1210s 05:21:08 INFO - Completed test suite (00:20:10) 05:21:08 INFO - Working with test: dromaeo_css 05:21:08 INFO - Generating results file: dromaeo_css 05:21:08 INFO - Working with test: kraken 05:21:08 INFO - Generating results file: kraken 05:21:08 INFO - javascript benchmark 05:21:08 INFO - Working with test: v8_7 05:21:08 INFO - Generating results file: v8_7 05:21:08 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:21:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:21:08 INFO - process_Request line: dromaeo_css 6796.94 graph.html#tests=[[72,64,43]] 05:21:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:21:08 INFO - process_Request line: kraken 1521.20 graph.html#tests=[[232,64,43]] 05:21:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:21:08 INFO - process_Request line: v8_7 20735.85 graph.html#tests=[[230,64,43]] 05:21:08 INFO - RETURN: dromaeo_css: 6796.94 05:21:08 INFO - RETURN: kraken: 1521.20 05:21:08 INFO - RETURN: v8_7: 20735.85 05:21:08 INFO - javascript benchmark 05:21:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3273.8526766295513, 3310.1890036940968, 3330.1175188575016, 3349.464085746281, 3360.529525866379, 5347.59893008024, 5453.209284653728, 5483.040467918113, 5483.561315094793, 5495.642783219088, 5384.219288203209, 5470.64440811347, 5560.972195139028, 5568.192612071247, 5585.525230355414, 4916.213405855064, 4978.875528111799, 5003.549680528752, 5143.27994080829, 5176.404713457944, 5097.158968770148, 5103.362079740033, 5114.335136432259, 5129.615278854082, 5138.0, 4859.878503037435, 4928.852134435972, 4939.777710003023, 5045.84862454127, 5087.847364579032, 5028.195488721787, 5041.521055499722, 5052.21690637948, 5066.164082926312, 5084.186530155157, 4927.236278376858, 5012.949870501285, 5039.09296326661, 5058.822941197041, 5071.39143302806, 5277.947220527784, 5358.812441564526, 5394.811181608625, 5447.237386765856, 5470.972645136789, 5894.793682221101, 5917.6449413034925, 5919.644821310735, 5930.822075337746, 5933.495652869511, 5729.083346664514, 5857.502112320458, 5948.851278718023, 5965.642061476282, 5979.641221526722, 5441.619086663895, 5554.972225138929, 5555.027870122753, 5569.10894256917, 5614.27014488118, 6095.634261944298, 6118.479929205978, 6122.20411346531, 6138.570300079041, 6139.171211886427, 5653.9151912721345, 5756.3380211276235, 5763.279590051244, 5849.415058494116, 5878.823635290948, 5936.970315148396, 5948.0, 5955.3151387590115, 5965.821025369246, 5989.2812862456785, 5851.414858514115, 5858.330375842865, 5907.32065812437, 5920.2895652521975, 5924.496417804448, 5629.493345598916, 5758.856028599319, 5791.189233507313, 5905.557083218776, 5961.761529538857, 4547.15877562652, 4547.295169248706, 4557.248054071041, 4561.2473941799235, 4587.243104887723, 4023.1312659599057, 4050.4936882889638, 4056.127932494469, 4093.815778289984, 4128.236276288836, 5350.438203988603, 5450.04624190765, 5462.426445223274, 5463.098588732894, 5480.725963701799, 5741.19623252745, 5777.45114214149, 5803.0, 5809.535237181015, 5926.140709597171, 5509.146082357241, 5514.91727624086, 5553.694546799965, 5560.0, 5616.550675945915, 5000.424951130593, 5021.974890125526, 5023.547880690755, 5053.444121146671, 5085.796568137307, 5954.07711804671, 6022.668753218615, 6141.877162456726, 6143.818944274807, 6146.569740118238, 5962.9105563415715, 6026.849328766816, 6030.185924900083, 6030.668313242813, 6039.728212230548, 6216.222972128484, 6216.378362163748, 6217.253929528486, 6230.937690623217, 6241.625502469867, 5667.4615911488345, 5797.913031304618, 5833.212516310244, 5930.229070220844, 5946.316173640087, 5940.138679891305, 5951.018082016419, 5973.193618861572, 5992.490638295793, 6009.338972712911, 5824.767009319749, 5827.70861456917, 5829.446202610745, 5839.620424672383, 5859.062549991981, 5601.04782187021, 5697.316322041382, 5759.078547432391, 5797.826065218051, 5841.065429531424, 5672.461116193955, 5726.856828579319, 5732.684702341411, 5757.8560535986935, 5784.334801497882, 5773.942260577341, 5781.4218578141845, 5782.363939966516, 5785.971070144622, 5852.18069470283, 5508.889822203613, 5626.099824028136, 5658.575606829422, 5697.914531281951, 5713.857153571194], "unit": "score", "name": "dojo.html", "value": 5450.566966758669}, {"lowerIsBetter": false, "replicates": [522.4984015345268, 523.3719536556133, 531.8244979156877, 548.131212028934, 552.4806681719186, 34135.829320853394, 34763.478547821775, 34870.0, 34918.650813491855, 34933.82533087331, 37537.624623753756, 38119.04702382435, 38207.0, 38431.03922401941, 38500.614993850126, 8382.832343353144, 8623.95688021559, 8635.352348573851, 8636.093210212932, 8640.913590864106, 8469.703560375388, 8540.060593334729, 8588.828223435528, 8792.07683193265, 8802.119788021211, 8729.563521823884, 8840.469571825712, 8842.159994800484, 8851.867221991675, 8873.733787986339, 8648.481091134552, 8663.133686631318, 8694.347923905669, 8756.605952732143, 8764.649414023432, 8589.355798315151, 8694.913050869536, 8737.60680769367, 8740.169683880022, 8742.475451472932, 38066.23867522662, 38438.423423648666, 38618.42072368917, 38640.613593863985, 38667.0, 2839.5882597023524, 3279.212988882675, 3282.097423208637, 3291.555639988595, 3426.7258619310396, 25911.740882591308, 25920.351991200183, 26611.46777064467, 26796.866015669795, 26967.46065078707, 3647.8176091195332, 3657.9817100914593, 3666.7433279670436, 3707.7404581679293, 3836.079340958178, 303290.0, 307078.0, 307857.0, 307903.0, 307941.0, 40344.19311613751, 52324.476755232725, 52992.20511692328, 53033.73483132559, 53238.73380633072, 38551.0, 38683.0, 38763.612363876004, 38789.806050969564, 38830.41754373687, 14054.227017513931, 14195.78706319406, 14220.0, 14276.14343139415, 14293.142411455347, 10798.136149108053, 10858.0, 10870.510827012804, 10872.402017888933, 10899.727506812234, 13363.933180334036, 13395.732085358239, 13740.381682824296, 13856.792148117785, 13879.236641984586, 5618.101103823368, 5645.576581756384, 5712.428757124254, 5769.798057067983, 5792.9420705793245, 919.4713040002025, 955.617752898846, 1030.5105075089423, 1038.4651904269308, 1078.3206579854798, 27804.72195278021, 28084.578731319045, 28115.0, 28183.154505364873, 28366.71633283682, 995.5918073589794, 1013.8377859542438, 1018.5518371916481, 1021.4637315409469, 1050.9527071281811, 13393.73212535744, 13564.93217533906, 13808.0, 13926.234057126752, 13929.164250145024, 374340.0, 380996.0, 382188.0, 382721.0, 384246.0, 49935.0, 50056.49943500591, 50265.24602130971, 50311.0, 50482.0, 1297.5328881602616, 1339.5177736015028, 1350.4868150103096, 1352.019785655392, 1354.627477443691, 24983.250502484956, 25242.0, 26038.609420858324, 26409.867950660122, 26503.0, 41065.79467102645, 41112.794436028824, 41214.58785412108, 41466.792666036476, 41517.16965660609, 286700.0, 286719.0, 286828.0, 288118.0, 289009.0, 30368.69631303747, 30799.384012320075, 31057.378852423277, 31114.0, 31188.844055779577, 40048.79975600103, 40127.799361004174, 40230.1953960925, 40359.96727570268, 40617.59382406138, 29576.556351655174, 29857.25356866096, 29948.25129371696, 37289.0, 37921.81039094787, 34528.82735586306, 34973.300533989684, 35685.82157089198, 35900.64099358973, 36051.098722532144, 33806.49290260697, 34683.653163469055, 34707.30585388227, 34734.30531389308, 34962.47556286607, 29613.703862961956, 31780.0, 31961.200969975936, 32605.673943260263, 32696.673033270315, 24106.0, 24135.75864241335, 24174.637380438955, 24183.395415114763, 24302.635460467754], "unit": "score", "name": "ext.html", "value": 17297.56283143554}, {"lowerIsBetter": false, "replicates": [356.0564504064228, 359.27068051854735, 361.2035461806717, 361.95656521217444, 362.9727770417216, 13376.59870203893, 14077.4369025239, 15613.921930390346, 17149.485515434524, 17642.558936026573, 10863.99999999998, 10865.239433239676, 10903.34579925205, 10966.945165274183, 10995.780084398308, 4852.078105160017, 4960.23116416956, 4974.97512512437, 4975.7263350515705, 5243.2135179723155, 5338.652987555816, 5365.356157261134, 5369.892602147955, 5388.811391601294, 5395.325584301962, 5172.19830926207, 5329.653572517794, 5379.327584051994, 5379.757910894019, 5398.64908780928, 5312.123499622558, 5325.334333208349, 5332.626716129853, 5337.332833395825, 5347.224652425377, 5051.419086804991, 5123.180291153435, 5156.1750119981, 5275.28783614211, 5312.362516498045, 12214.694632634166, 12355.938220308932, 12391.75216495674, 14658.70682586353, 19245.615087698166, 922.861570764384, 2106.020700374318, 2174.3911704722545, 2269.8524595901213, 2312.5143719818857, 8995.5052472114, 9069.183773460354, 9076.77308067297, 9298.721038368793, 9452.480113593749, 1708.453294945618, 1716.5451155443693, 1794.4616615015573, 1850.4591513616256, 1856.8236017578308, 42726.57273427257, 62688.68655656738, 62811.68594157, 62844.0, 63810.0, 10280.434576098236, 10313.22650801178, 10350.482475876326, 10378.740531486774, 10395.84406233907, 13183.406746696422, 13247.801282980763, 13268.40292186854, 13320.6669833253, 13338.0, 7220.494565380373, 7394.704211831574, 7400.851982960311, 7483.775486735407, 7541.057367829021, 7170.139583250043, 7214.278572142849, 7242.674079666428, 7244.130704315516, 7286.198518162998, 4346.7609281489185, 4428.800703968329, 4432.556744325606, 4445.844395446144, 4485.955140448619, 1813.111575328106, 1832.1663643042384, 1835.6787562176567, 1846.2891786662233, 1862.6774989757153, 404.2053283421599, 407.301477965285, 907.7140700679265, 959.5538074795254, 976.3751199232497, 10434.947825260826, 10785.622503212508, 10797.136229101652, 10966.122710183166, 11007.724806879893, 439.14147840970827, 448.5626514148679, 449.90897074593977, 453.3517070589089, 456.728246693217, 5635.520980716685, 5862.560307976919, 5870.5890587659305, 5905.291365036223, 5942.227510423703, 526176.0, 532935.0, 543120.0, 547659.0, 549450.0, 77815.61092194503, 78676.0, 78960.0, 80228.59885700651, 80997.19002810014, 474.1915034865546, 475.48884948679614, 476.5187160967448, 477.7109848541652, 482.60185347088793, 9849.261305402268, 9951.15415189717, 9958.15355694774, 10011.749706257402, 10050.396976181453, 32691.0, 32923.67076329206, 33011.0, 33117.006489805346, 33786.662133378355, 36777.26445471022, 37446.0, 38118.809405952794, 38199.0, 40106.39840402338, 9046.592903319499, 9253.768655783659, 9505.0, 9521.333506654744, 9536.618535258513, 11232.382218978035, 11319.207655464368, 13487.865121348661, 17160.656786863943, 17727.113644317473, 13950.162990220619, 14081.788773168615, 14691.779623305445, 14699.853001469848, 15252.466163684661, 13542.59372218835, 13953.511627093003, 14102.647433814236, 14233.217173055582, 14308.0, 13956.2324072177, 14060.437582496586, 14268.21524816145, 14915.776263355841, 15381.769273460683, 9171.724848254564, 9539.475328856703, 9585.664501742405, 9602.231821454407, 9828.4102953823, 13516.459341626225, 13879.0, 14115.858841411455, 14676.192809395585, 14837.703245934805], "unit": "score", "name": "jquery.html", "value": 7766.339115572476}, {"lowerIsBetter": false, "replicates": [1382.3710211853606, 1447.5874375802891, 1573.32347090751, 1743.9825601743978, 1768.9115544222786, 7575.886361704572, 7604.847903041936, 7717.575533345678, 7742.303192712662, 7763.18486558911, 7512.586807725573, 7513.699452021912, 7598.810029749259, 7609.277118673731, 7612.467127301091, 2237.183428048763, 2272.4432514034, 2272.8522646028036, 2274.306336567346, 2274.8180145588394, 2237.5636750833596, 2265.3430505153488, 2269.580127676385, 2277.2826559633745, 2290.0839664134396, 2194.8024677779, 2200.878951657658, 2248.168177774226, 2253.7971582557566, 2260.175036111824, 2197.143114185469, 2228.6434170532716, 2245.62947113726, 2247.831412644042, 2259.3109101723967, 2218.4675677837363, 2231.3863687486073, 2233.7877901599486, 2235.6870038194666, 2245.607018771708, 7430.814229644248, 7465.85068298631, 7535.773926782151, 7559.28186822251, 7566.394688424913, 4480.417545719069, 4548.909021819578, 4554.4990051094355, 4576.8626941191815, 4580.3358513015755, 2850.230437781808, 2920.6495220573665, 2950.9114726558237, 2959.6004539387122, 2978.612780338564, 945.3146468810127, 952.2762700347716, 970.6602689058843, 974.133021610767, 1012.5392946209457, 10429.530671119817, 10509.737256568647, 10544.209184311207, 10598.0, 10646.893531064668, 4059.5331536873045, 4077.510698716173, 4098.098418347959, 4146.834126634961, 4158.438610787565, 8498.447600906045, 8588.871166932377, 8593.613287401957, 8597.613107410181, 8648.697295594624, 4572.542745725467, 4578.5650363215445, 4609.976950115228, 4614.377059096979, 4633.7683115844075, 4197.118605092965, 4204.747715137101, 4232.661387089025, 4233.026403927052, 4233.70364074518, 3338.6828251316088, 3351.731861451078, 3352.6814952579466, 3361.647027062172, 3391.932161356759, 1017.399734156851, 1018.6231094495084, 1023.3348323589578, 1023.9232057595561, 1034.7826956339102, 909.9226565741853, 969.9466529340813, 1074.0655629602295, 1132.6318946342471, 1301.5249433956537, 7040.823979400556, 7053.823654408681, 7112.537685050455, 7129.572225666373, 7142.321479459443, 1161.0595417711681, 1161.2916121166081, 1178.6876477733408, 1185.3658292813304, 1190.1966172833477, 5705.372409035002, 5751.827445176651, 5761.769529218785, 5777.942220577825, 5797.130430435384, 8807.0, 8996.0, 9105.544722763967, 9261.583228754722, 9293.581788819383, 9164.587593558306, 9182.403143795633, 9216.078392160864, 9269.351145419756, 9282.90717092834, 7229.89155162673, 7265.818354541073, 7287.380572651278, 7287.8339465686295, 7372.741954031583, 6949.583025018515, 6956.965215173892, 6965.407940325129, 6969.7212111517, 6973.65131743421, 8117.959410203148, 8202.26179643835, 8268.958655206685, 8337.458065225741, 8367.0, 8371.581420929051, 8501.787455313666, 8523.232909038215, 8545.102764209669, 8665.653373864974, 6462.676866156579, 6567.080608714688, 6600.768973085919, 6735.461163106842, 6757.628330441873, 7336.559806411632, 7345.265473452612, 7372.225916278713, 7392.112946446461, 7397.334239918433, 6808.251092379934, 6927.0, 6951.0616066830335, 7055.435565154673, 7055.858882822417, 6569.507286953402, 6641.667916604247, 6752.898706519504, 6824.405250001235, 6831.077804496329, 6546.738130474728, 6689.063531105552, 6693.631850248283, 6709.194896612437, 6735.797926062226, 6201.441870231521, 6217.067439883873, 6234.719437625227, 6255.56211065221, 6278.340774218641, 6220.502359811295, 6285.528585356025, 6286.0, 6347.523935704933, 6395.552311338161], "unit": "score", "name": "mootools.html", "value": 4374.820186910635}, {"lowerIsBetter": false, "replicates": [325.2227177046858, 332.2922175765619, 334.83927714696944, 335.9428897087495, 339.6467673619436, 6238.376162383765, 6271.404216599416, 6283.685815709219, 6294.43350098491, 6453.548251622388, 6189.659568723719, 6222.906656400158, 6249.625022498653, 6272.090546870701, 6277.995520716686, 4673.462551806551, 4687.437507499097, 4689.249720044793, 4693.084848454553, 4702.083093796711, 4704.341392205094, 4705.458872229703, 4705.976470117662, 4706.058788242348, 4707.576318131368, 4500.909981800362, 4535.0, 4597.126545956275, 4614.907701845961, 4657.650676199281, 4599.471060828014, 4610.124076425485, 4614.976925115353, 4617.284320930261, 4619.214733495281, 3990.2817492851277, 3993.0, 3994.400839874013, 3997.320455522568, 4001.6998725095737, 5852.180694702745, 5918.585699001072, 5918.940810591882, 5928.525717942554, 5931.881362372772, 5249.4488078751565, 5410.1073322901675, 5437.293151890269, 5465.398806131322, 5465.9180112298345, 6538.215414150285, 6553.213614366259, 6560.179977502812, 6583.341665833426, 6585.078089067534, 4480.865574032784, 4498.8425405110665, 4499.505054444008, 4503.684742068057, 4506.121306345264, 6756.527043106985, 6837.1111755471475, 6868.313168683142, 6870.866307059379, 6914.101166848328, 4605.171069207508, 4609.953900460952, 4610.538946105363, 4611.054733779567, 4627.213373726475, 4661.114388266218, 4663.626909847204, 4667.719936803803, 4671.346011558385, 4683.414573178353, 5421.647592906448, 5422.810201643002, 5432.809851655173, 5436.619436639477, 5440.102383106743, 6436.455250739788, 6603.7688680895935, 6605.603663780189, 6620.073189753439, 6626.105475760711, 1637.6724655069033, 1660.2279939827797, 1661.8919770214898, 1662.8087769906374, 1662.9002259864446, 1070.5717712914895, 1073.758404359013, 1077.06833588945, 1082.258652822819, 1090.3621381491757, 6275.6548389839, 6285.59143655661, 6289.96855015722, 6296.622202667854, 6302.149209856702, 6776.356246156607, 6808.829779255559, 6819.386255237053, 6820.04519367289, 6831.9658401707675, 6184.226971628546, 6262.1859158310035, 6295.874082518416, 6381.680915954184, 6384.616922984543, 3704.2591481703766, 3719.442083687414, 3729.049092481454, 3735.364987952055, 3762.473253744478, 7169.928300716926, 7173.964130179315, 7184.0, 7201.963990180016, 7234.6020968847215, 6937.7571784987285, 7101.431885449152, 7124.92875071253, 7132.786016419515, 7146.14246290438, 7137.179224389158, 7165.390941770008, 7166.964165179245, 7168.569885806868, 7169.354758071799, 6855.657217139223, 6858.348456896587, 6868.347506986828, 6902.689378977858, 6904.861902762017, 6616.702248398929, 6796.150481189851, 6798.898016529657, 6805.979103134569, 6810.9318906810295, 7142.35718785291, 7157.785266442015, 7189.209186989322, 7201.891971620535, 7205.027321311556, 4574.382458368078, 4613.677042606985, 4627.907441851076, 4631.791569379453, 4635.397398338195, 6615.66921653925, 6834.555753875982, 6857.759978400732, 6887.104676392037, 6917.688704008231, 6707.932920670731, 6730.831729206809, 6737.157855268091, 6738.7304507819135, 6747.0, 6575.736970521317, 6663.600183988976, 6673.366030227121, 6715.664216789239, 6719.731210751711, 6578.76974305897, 6588.308227636029, 6588.670566471753, 6591.868162636624, 6594.868102637824, 6714.630695311805, 6727.0, 6728.629925354153, 6765.492588055817, 6783.084283621648, 6430.099786030053, 6526.151600291932, 6535.509836762167, 6564.212294524687, 6570.737170513317], "unit": "score", "name": "prototype.html", "value": 4961.141394241859}, {"lowerIsBetter": false, "replicates": [729.3800269770695, 754.2269174096552, 759.3279947246685, 787.5432249295405, 852.8848605438268, 15133.47032853849, 15157.469488567902, 15168.0, 15174.393024279016, 15212.23938803061, 13084.803727944089, 13181.60455186346, 13194.604161875135, 13203.0, 13221.669458263548, 790.695582200851, 795.3597354129923, 807.0718673525434, 808.6805711743858, 809.4374409785202, 799.3365506629484, 800.8358286551272, 804.7103042904549, 806.9152738962413, 808.6078252047752, 836.9874451883227, 837.9622916968721, 841.0706169682504, 841.2302742990187, 843.5613480989881, 827.0695467598952, 828.3745771942146, 828.5401602110826, 831.1854382704983, 835.5822088955522, 608.4888693497439, 615.0927382111395, 615.0988801405917, 616.8457885528618, 618.9721462534196, 13261.3369331534, 13268.535601254007, 13301.0, 13386.062975591713, 13422.127561708458, 12217.0, 12688.49246030167, 12875.935620321932, 12930.159539629894, 13135.86864131356, 9767.365121267096, 10471.476426178737, 10846.620368287073, 11193.16051296156, 11244.606438774685, 3673.1000904778234, 3690.9815450922843, 3691.667749902522, 3793.013816407754, 3819.5034645495907, 45375.546244537465, 46417.30374044426, 46470.0, 46594.30108548375, 47490.0, 9622.230221582256, 9815.75460613476, 10027.448490333101, 10194.694159175237, 10214.285000050073, 18167.27330906749, 18175.09124543794, 18180.45458636243, 18208.726869096976, 18229.54426139357, 7407.0, 7483.289087536676, 7598.240175982468, 7730.304272615492, 7769.53382797034, 4155.1897380010605, 4161.0, 4192.0, 4193.748375097504, 4234.428352172417, 3011.1869795155185, 3019.3961207758534, 3025.213444504445, 3026.0770465008386, 3026.4703676856902, 535.9062164121264, 557.5511713071016, 562.5190462154799, 570.5578176912926, 573.4666759913321, 485.7911098227725, 509.17005281391096, 591.721890711365, 625.8967270400333, 662.2384258103124, 8085.272325490734, 8222.547759873265, 8357.331413486907, 8439.324854011664, 8470.717459683483, 526.3000209721062, 537.8386484054846, 565.251042368863, 593.664579512574, 619.4641634985705, 4182.0, 4202.957970420318, 4245.660347172219, 4271.444712187458, 4414.183376075436, 51857.7407112962, 52517.89928402821, 53159.73420132875, 53335.46664533305, 53411.19883201755, 46975.765121174176, 48341.274880876816, 49536.75231623819, 49638.75180624074, 50303.496965030616, 42770.14459710789, 44061.0, 44598.77700611476, 45083.0, 45269.32096018562, 8270.83458330818, 8388.0, 8916.821663566821, 8972.147645973622, 8988.325875559229, 33423.33153336968, 33838.66161338355, 33847.49228761521, 34058.65941340555, 34131.0, 39226.0, 41743.7912810434, 42400.0, 42905.785471073694, 43000.56999429966, 11102.500387482422, 11125.332480051224, 11239.775204495701, 11418.486168122288, 11458.82811757841, 11194.272372295774, 11224.775504490028, 11245.943770281096, 11665.416729163338, 11770.411479426166, 11095.500702468247, 11336.489857956576, 11388.202825802115, 11564.653060408202, 11650.88349116498, 11459.389278669763, 11576.594819181288, 11788.351640659846, 11894.286342819458, 12057.276563406223, 10239.078482936273, 10752.0, 10762.192835537522, 10886.891131088587, 11009.119270458184, 9277.536123193948, 9366.415905159241, 9428.340016199074, 9477.336586438883, 9613.567389467351, 8415.45299555527, 8627.525486098324, 8838.0, 9293.210077143249, 9538.332316737762], "unit": "score", "name": "yui.html", "value": 6203.8455782691235}], "name": "dromaeo_css", "value": 6796.938066337608}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 113.0, 111.0, 112.0, 123.0, 111.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 158.0, 158.0, 133.0, 157.0, 150.0, 129.0, 161.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 162.0, 162.0, 161.0, 163.0, 163.0, 169.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 73.0, 71.0, 71.0, 71.0, 129.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 77.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 145.0, 95.0, 96.0, 96.0, 146.0, 97.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 57.0, 59.0, 58.0, 66.0, 57.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 85.0, 87.0, 94.0, 87.0, 88.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 118.0, 120.0, 129.0, 128.0, 120.0, 127.0, 125.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [143.0, 159.0, 153.0, 152.0, 157.0, 142.0, 151.0, 151.0, 153.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 74.0, 70.0, 70.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1521.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [189.53752843062927], "unit": "score", "name": "DeltaBlue", "value": 348.8385680000001}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [719.9424046076314], "unit": "score", "name": "Earley", "value": 925.7171069999997}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [24951.219512195123], "unit": "score", "name": "RegExp", "value": 36.51064027370476}, {"lowerIsBetter": false, "replicates": [823.7232289950576], "unit": "score", "name": "Splay", "value": 98.93007399999998}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20735.845007506217}]} 05:21:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20735.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1521.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6796.94"}}} 05:21:08 INFO - Return code: 0 05:21:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:21:08 INFO - # TBPL SUCCESS # 05:21:08 INFO - Running post-action listener: _resource_record_post_action 05:21:08 INFO - Running post-run listener: _resource_record_post_run 05:21:09 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 431419392; Read time: 212; Write time: 250576 05:21:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 69316608; Read time: 0; Write time: 50392 05:21:09 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 20480; Write bytes: 316076032; Read time: 116; Write time: 170060 05:21:09 INFO - Running post-run listener: _upload_blobber_files 05:21:09 INFO - Blob upload gear active. 05:21:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:21:09 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:09 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:09 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:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:10 INFO - (blobuploader) - INFO - Done attempting. 05:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:11 INFO - (blobuploader) - INFO - Done attempting. 05:21:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:11 INFO - Return code: 0 05:21:11 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:21:11 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2424a94e3e14aa2dd4e83c43a8a84d57b6e4e69c30349c9e5d0a8078dfc3e649504061bd7e86c51f99842766b7a08df32a066c6c2955cf38985c0fb145f6d7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ccd5fb449f608932a70393fca406687d81fa30fcb1a5860375195a01a1a6d228bb6fb6248162ca5d89f5ecbd3dcbab80840b511d3439dfeb9e0314bf96a556"} 05:21:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:21:11 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:21:11 INFO - Contents: 05:21:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2424a94e3e14aa2dd4e83c43a8a84d57b6e4e69c30349c9e5d0a8078dfc3e649504061bd7e86c51f99842766b7a08df32a066c6c2955cf38985c0fb145f6d7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ccd5fb449f608932a70393fca406687d81fa30fcb1a5860375195a01a1a6d228bb6fb6248162ca5d89f5ecbd3dcbab80840b511d3439dfeb9e0314bf96a556"} 05:21:11 INFO - Copying logs to upload dir... 05:21:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1305.674584 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-01-05 05:21:11.705344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:11.712699) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2424a94e3e14aa2dd4e83c43a8a84d57b6e4e69c30349c9e5d0a8078dfc3e649504061bd7e86c51f99842766b7a08df32a066c6c2955cf38985c0fb145f6d7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ccd5fb449f608932a70393fca406687d81fa30fcb1a5860375195a01a1a6d228bb6fb6248162ca5d89f5ecbd3dcbab80840b511d3439dfeb9e0314bf96a556"} 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.011167 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2424a94e3e14aa2dd4e83c43a8a84d57b6e4e69c30349c9e5d0a8078dfc3e649504061bd7e86c51f99842766b7a08df32a066c6c2955cf38985c0fb145f6d7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ccd5fb449f608932a70393fca406687d81fa30fcb1a5860375195a01a1a6d228bb6fb6248162ca5d89f5ecbd3dcbab80840b511d3439dfeb9e0314bf96a556"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:11.741835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:11.742331) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1451997665.380195-921038423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:21:11.825606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 05:21:11.826114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 05:21:11.826588) ========= ========= Total master_lag: 0.23 =========