builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1452170997.35 results: success (0) buildid: 20160107023008 builduid: a64025efe7534df7aaf14b6681a21228 revision: a236b6aa15d68b434a8eacb2d21aa1f4a27f42f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.352398) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.352981) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.353286) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.379582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.379887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.457949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.458205) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038785 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.521820) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.522099) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.522490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.522784) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 04:49:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2016-01-07 04:49:58 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.640993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.641336) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050010 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:57.702916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 04:49:57.703234) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a236b6aa15d68b434a8eacb2d21aa1f4a27f42f7 --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 a236b6aa15d68b434a8eacb2d21aa1f4a27f42f7 --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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 04:49:58,653 truncating revision to first 12 chars 2016-01-07 04:49:58,653 Setting DEBUG logging. 2016-01-07 04:49:58,653 attempt 1/10 2016-01-07 04:49:58,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a236b6aa15d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 04:49:59,602 unpacking tar archive at: fx-team-a236b6aa15d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238110 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 04:49:58.954969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:58.955278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:58.964475) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:58.964793) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 04:49:58.965213) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-07 04:49:58.965498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:59 INFO - MultiFileLogger online at 20160107 04:49:59 in /builds/slave/test-pgo 04:49:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:49:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:50:00 INFO - {'append_to_log': False, 04:50:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:50:00 INFO - 'blob_upload_branch': 'Fx-Team', 04:50:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:50:00 INFO - 'branch': 'Fx-Team', 04:50:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:00 INFO - 'config_files': ('talos/linux_config.py',), 04:50:00 INFO - 'default_actions': ('clobber', 04:50:00 INFO - 'read-buildbot-config', 04:50:00 INFO - 'download-and-extract', 04:50:00 INFO - 'populate-webroot', 04:50:00 INFO - 'create-virtualenv', 04:50:00 INFO - 'install', 04:50:00 INFO - 'run-tests'), 04:50:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:00 INFO - 'download_minidump_stackwalk': True, 04:50:00 INFO - 'download_symbols': 'ondemand', 04:50:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:00 INFO - 'installer_path': 'installer.exe', 04:50:00 INFO - 'log_level': 'info', 04:50:00 INFO - 'log_name': 'talos', 04:50:00 INFO - 'log_to_console': True, 04:50:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:50:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:50:00 INFO - 'opt_config_files': (), 04:50:00 INFO - 'pip_index': False, 04:50:00 INFO - 'sps_profile': False, 04:50:00 INFO - 'sps_profile_interval': 0, 04:50:00 INFO - 'suite': 'dromaeojs', 04:50:00 INFO - 'system_bits': '32', 04:50:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:00 INFO - 'title': 'talos-linux64-ix-068', 04:50:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:00 INFO - 'use_talos_json': True, 04:50:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:50:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:00 INFO - 'work_dir': 'build'} 04:50:00 INFO - ##### 04:50:00 INFO - ##### Running clobber step. 04:50:00 INFO - ##### 04:50:00 INFO - Running pre-action listener: _resource_record_pre_action 04:50:00 INFO - Running main action method: clobber 04:50:00 INFO - rmtree: /builds/slave/test-pgo/build 04:50:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:50:01 INFO - Running post-action listener: _resource_record_post_action 04:50:01 INFO - ##### 04:50:01 INFO - ##### Running read-buildbot-config step. 04:50:01 INFO - ##### 04:50:01 INFO - Running pre-action listener: _resource_record_pre_action 04:50:01 INFO - Running main action method: read_buildbot_config 04:50:01 INFO - Using buildbot properties: 04:50:01 INFO - { 04:50:01 INFO - "project": "", 04:50:01 INFO - "product": "firefox", 04:50:01 INFO - "script_repo_revision": "production", 04:50:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:50:01 INFO - "repository": "", 04:50:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:50:01 INFO - "buildid": "20160107023008", 04:50:01 INFO - "pgo_build": "True", 04:50:01 INFO - "basedir": "/builds/slave/test-pgo", 04:50:01 INFO - "buildnumber": 570, 04:50:01 INFO - "slavename": "talos-linux64-ix-068", 04:50:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:50:01 INFO - "platform": "ubuntu64_hw", 04:50:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:50:01 INFO - "branch": "fx-team", 04:50:01 INFO - "repo_path": "integration/fx-team", 04:50:01 INFO - "revision": "a236b6aa15d68b434a8eacb2d21aa1f4a27f42f7", 04:50:01 INFO - "stage_platform": "linux64-pgo", 04:50:01 INFO - "builduid": "a64025efe7534df7aaf14b6681a21228", 04:50:01 INFO - "slavebuilddir": "test" 04:50:01 INFO - } 04:50:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:50:01 INFO - Running post-action listener: _resource_record_post_action 04:50:01 INFO - ##### 04:50:01 INFO - ##### Running download-and-extract step. 04:50:01 INFO - ##### 04:50:01 INFO - Running pre-action listener: _resource_record_pre_action 04:50:01 INFO - Running main action method: download_and_extract 04:50:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:01 INFO - https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/test_packages.json 04:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/test_packages.json 04:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:50:02 INFO - Downloaded 1302 bytes. 04:50:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:50:02 INFO - Using the following test package requirements: 04:50:02 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:02 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:50:02 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'jsshell-linux-x86_64.zip'], 04:50:02 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:50:02 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:02 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:50:02 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:50:02 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:50:02 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:02 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:50:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:50:02 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:50:02 INFO - https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/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:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/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:50:05 INFO - Downloaded 24102051 bytes. 04:50:05 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:50:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:50:05 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:50:06 INFO - Return code: 0 04:50:06 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:50: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')]} 04:50:06 INFO - https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:50:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:50:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/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:50:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/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:50:10 INFO - Downloaded 24102051 bytes. 04:50:10 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:50:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:50:10 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:50:11 INFO - Return code: 0 04:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:11 INFO - https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:50:14 INFO - Downloaded 11132285 bytes. 04:50:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:50:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:50:14 INFO - Return code: 0 04:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:14 INFO - https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:50:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:50:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:50:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:50:16 INFO - Downloaded 55070039 bytes. 04:50:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:50:16 INFO - mkdir: /builds/slave/test-pgo/properties 04:50:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:50:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:50:16 INFO - Contents: 04:50:16 INFO - build_url:https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:50:16 INFO - Running post-action listener: _resource_record_post_action 04:50:16 INFO - Running post-action listener: set_extra_try_arguments 04:50:16 INFO - ##### 04:50:16 INFO - ##### Running populate-webroot step. 04:50:16 INFO - ##### 04:50:16 INFO - Running pre-action listener: _resource_record_pre_action 04:50:16 INFO - Running main action method: populate_webroot 04:50:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:50:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:50:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:50:16 INFO - '--tppagecycles', 04:50:16 INFO - '7'], 04:50:16 INFO - 'tests': ['tsvgm']}}, 04:50:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:50:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:50:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:50:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:50:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'tests': ['damp', 'tps']}, 04:50:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['damp', 'tps']}, 04:50:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:50:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:50:16 INFO - 'other': {'tests': ['a11yr', 04:50:16 INFO - 'ts_paint', 04:50:16 INFO - 'tpaint', 04:50:16 INFO - 'sessionrestore', 04:50:16 INFO - 'sessionrestore_no_auto_restore']}, 04:50:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['a11yr', 04:50:16 INFO - 'ts_paint', 04:50:16 INFO - 'tpaint', 04:50:16 INFO - 'sessionrestore', 04:50:16 INFO - 'sessionrestore_no_auto_restore']}, 04:50:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['a11yr', 04:50:16 INFO - 'ts_paint', 04:50:16 INFO - 'tpaint', 04:50:16 INFO - 'sessionrestore', 04:50:16 INFO - 'sessionrestore_no_auto_restore']}, 04:50:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['a11yr', 04:50:16 INFO - 'ts_paint', 04:50:16 INFO - 'tpaint', 04:50:16 INFO - 'sessionrestore', 04:50:16 INFO - 'sessionrestore_no_auto_restore']}, 04:50:16 INFO - 'other_l64': {'tests': ['a11yr', 04:50:16 INFO - 'ts_paint', 04:50:16 INFO - 'tpaint', 04:50:16 INFO - 'sessionrestore', 04:50:16 INFO - 'sessionrestore_no_auto_restore']}, 04:50:16 INFO - 'other_nol64': {'tests': ['a11yr', 04:50:16 INFO - 'ts_paint', 04:50:16 INFO - 'tpaint', 04:50:16 INFO - 'sessionrestore', 04:50:16 INFO - 'sessionrestore_no_auto_restore']}, 04:50:16 INFO - 'svgr': {'tests': ['tsvgx', 04:50:16 INFO - 'tsvgr_opacity', 04:50:16 INFO - 'tart', 04:50:16 INFO - 'tscrollx', 04:50:16 INFO - 'cart']}, 04:50:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['tsvgx', 04:50:16 INFO - 'tsvgr_opacity', 04:50:16 INFO - 'tart', 04:50:16 INFO - 'tscrollx', 04:50:16 INFO - 'cart']}, 04:50:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'tests': ['tp5o']}, 04:50:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'talos_options': ['--e10s'], 04:50:16 INFO - 'tests': ['tp5o']}, 04:50:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'talos_options': ['--xperf_path', 04:50:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:16 INFO - 'tests': ['tp5n']}, 04:50:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:16 INFO - 'talos_options': ['--e10s', 04:50:16 INFO - '--xperf_path', 04:50:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:16 INFO - 'tests': ['tp5n']}}, 04:50:16 INFO - 'talos.zip': {'path': '', 04:50:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:50:16 INFO - Running post-action listener: _resource_record_post_action 04:50:16 INFO - ##### 04:50:16 INFO - ##### Running create-virtualenv step. 04:50:16 INFO - ##### 04:50:16 INFO - Running pre-action listener: _resource_record_pre_action 04:50:16 INFO - Running main action method: create_virtualenv 04:50:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:50:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:50:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:50:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:50:16 INFO - Using real prefix '/usr' 04:50:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:50:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:19 INFO - Installing pip.................done. 04:50:19 INFO - Return code: 0 04:50:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:19 INFO - Using env: {'DISPLAY': ':0', 04:50:19 INFO - 'HOME': '/home/cltbld', 04:50:19 INFO - 'LANG': 'en_US.UTF-8', 04:50:19 INFO - 'LANGUAGE': 'en_US:en', 04:50:19 INFO - 'LOGNAME': 'cltbld', 04:50:19 INFO - 'MAIL': '/var/mail/cltbld', 04:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:19 INFO - 'MOZ_NO_REMOTE': '1', 04:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:19 INFO - 'NO_EM_RESTART': '1', 04:50:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:19 INFO - 'SHELL': '/bin/bash', 04:50:19 INFO - 'SHLVL': '1', 04:50:19 INFO - 'TERM': 'linux', 04:50:19 INFO - 'TMOUT': '86400', 04:50:19 INFO - 'USER': 'cltbld', 04:50:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:19 INFO - '_': '/tools/buildbot/bin/python'} 04:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50: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 04:50:19 INFO - Cleaning up... 04:50:19 INFO - Return code: 0 04:50:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:19 INFO - Using env: {'DISPLAY': ':0', 04:50:19 INFO - 'HOME': '/home/cltbld', 04:50:19 INFO - 'LANG': 'en_US.UTF-8', 04:50:19 INFO - 'LANGUAGE': 'en_US:en', 04:50:19 INFO - 'LOGNAME': 'cltbld', 04:50:19 INFO - 'MAIL': '/var/mail/cltbld', 04:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:19 INFO - 'MOZ_NO_REMOTE': '1', 04:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:19 INFO - 'NO_EM_RESTART': '1', 04:50:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:19 INFO - 'SHELL': '/bin/bash', 04:50:19 INFO - 'SHLVL': '1', 04:50:19 INFO - 'TERM': 'linux', 04:50:19 INFO - 'TMOUT': '86400', 04:50:19 INFO - 'USER': 'cltbld', 04:50:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:19 INFO - '_': '/tools/buildbot/bin/python'} 04:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:19 INFO - Downloading/unpacking psutil>=0.7.1 04:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:21 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:50:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:50:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:50:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:21 INFO - Installing collected packages: psutil 04:50:21 INFO - Running setup.py install for psutil 04:50:21 INFO - building 'psutil._psutil_linux' extension 04:50:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:50:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:50:21 INFO - building 'psutil._psutil_posix' extension 04:50:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:50: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 04:50:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:22 INFO - Successfully installed psutil 04:50:22 INFO - Cleaning up... 04:50:22 INFO - Return code: 0 04:50:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:22 INFO - Using env: {'DISPLAY': ':0', 04:50:22 INFO - 'HOME': '/home/cltbld', 04:50:22 INFO - 'LANG': 'en_US.UTF-8', 04:50:22 INFO - 'LANGUAGE': 'en_US:en', 04:50:22 INFO - 'LOGNAME': 'cltbld', 04:50:22 INFO - 'MAIL': '/var/mail/cltbld', 04:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:22 INFO - 'MOZ_NO_REMOTE': '1', 04:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:22 INFO - 'NO_EM_RESTART': '1', 04:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:22 INFO - 'SHELL': '/bin/bash', 04:50:22 INFO - 'SHLVL': '1', 04:50:22 INFO - 'TERM': 'linux', 04:50:22 INFO - 'TMOUT': '86400', 04:50:22 INFO - 'USER': 'cltbld', 04:50:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:22 INFO - '_': '/tools/buildbot/bin/python'} 04:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:50:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:50:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:50: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) 04:50:24 INFO - Installing collected packages: mozsystemmonitor 04:50:24 INFO - Running setup.py install for mozsystemmonitor 04:50:24 INFO - Successfully installed mozsystemmonitor 04:50:24 INFO - Cleaning up... 04:50:24 INFO - Return code: 0 04:50:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:24 INFO - Using env: {'DISPLAY': ':0', 04:50:24 INFO - 'HOME': '/home/cltbld', 04:50:24 INFO - 'LANG': 'en_US.UTF-8', 04:50:24 INFO - 'LANGUAGE': 'en_US:en', 04:50:24 INFO - 'LOGNAME': 'cltbld', 04:50:24 INFO - 'MAIL': '/var/mail/cltbld', 04:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:24 INFO - 'MOZ_NO_REMOTE': '1', 04:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:24 INFO - 'NO_EM_RESTART': '1', 04:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:24 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:24 INFO - 'SHELL': '/bin/bash', 04:50:24 INFO - 'SHLVL': '1', 04:50:24 INFO - 'TERM': 'linux', 04:50:24 INFO - 'TMOUT': '86400', 04:50:24 INFO - 'USER': 'cltbld', 04:50:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:24 INFO - '_': '/tools/buildbot/bin/python'} 04:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:50:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:50:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:50:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:50:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:50:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:26 INFO - Downloading docopt-0.6.1.tar.gz 04:50:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:50:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:50:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:50:26 INFO - Running setup.py install for blobuploader 04:50:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:50:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:50:27 INFO - Running setup.py install for requests 04:50:27 INFO - Running setup.py install for docopt 04:50:27 INFO - Successfully installed blobuploader requests docopt 04:50:27 INFO - Cleaning up... 04:50:27 INFO - Return code: 0 04:50:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:27 INFO - Using env: {'DISPLAY': ':0', 04:50:27 INFO - 'HOME': '/home/cltbld', 04:50:27 INFO - 'LANG': 'en_US.UTF-8', 04:50:27 INFO - 'LANGUAGE': 'en_US:en', 04:50:27 INFO - 'LOGNAME': 'cltbld', 04:50:27 INFO - 'MAIL': '/var/mail/cltbld', 04:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:27 INFO - 'MOZ_NO_REMOTE': '1', 04:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:27 INFO - 'NO_EM_RESTART': '1', 04:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:27 INFO - 'SHELL': '/bin/bash', 04:50:27 INFO - 'SHLVL': '1', 04:50:27 INFO - 'TERM': 'linux', 04:50:27 INFO - 'TMOUT': '86400', 04:50:27 INFO - 'USER': 'cltbld', 04:50:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:27 INFO - '_': '/tools/buildbot/bin/python'} 04:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:27 INFO - Running setup.py (path:/tmp/pip-R4QrHd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:27 INFO - Running setup.py (path:/tmp/pip-7HEKTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:27 INFO - Running setup.py (path:/tmp/pip-VmcgDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:27 INFO - Running setup.py (path:/tmp/pip-yxWOwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:28 INFO - Running setup.py (path:/tmp/pip-WuulwS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:28 INFO - Running setup.py (path:/tmp/pip-H9vARl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:28 INFO - Running setup.py (path:/tmp/pip-P4yBOK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:28 INFO - Running setup.py (path:/tmp/pip-TR0Cb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:28 INFO - Running setup.py (path:/tmp/pip-QA4bJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:28 INFO - Running setup.py (path:/tmp/pip-svrkiL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:28 INFO - Running setup.py (path:/tmp/pip-sMLREB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:28 INFO - Running setup.py (path:/tmp/pip-SY9Gem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:28 INFO - Running setup.py (path:/tmp/pip-qJbTZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:28 INFO - Running setup.py (path:/tmp/pip-y2jNq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:28 INFO - Running setup.py (path:/tmp/pip-6h88F6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:28 INFO - Running setup.py (path:/tmp/pip-R3vcRQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:28 INFO - Running setup.py (path:/tmp/pip-qdgSzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:28 INFO - Running setup.py install for manifestparser 04:50:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Running setup.py install for mozcrash 04:50:29 INFO - Running setup.py install for mozdebug 04:50:29 INFO - Running setup.py install for mozdevice 04:50:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Running setup.py install for mozfile 04:50:29 INFO - Running setup.py install for mozhttpd 04:50:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Running setup.py install for mozinfo 04:50:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Running setup.py install for mozInstall 04:50:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:50:29 INFO - Running setup.py install for mozleak 04:50:29 INFO - Running setup.py install for mozlog 04:50:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Running setup.py install for moznetwork 04:50:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Running setup.py install for mozprocess 04:50:30 INFO - Running setup.py install for mozprofile 04:50:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Running setup.py install for mozrunner 04:50:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Running setup.py install for mozscreenshot 04:50:30 INFO - Running setup.py install for moztest 04:50:30 INFO - Running setup.py install for mozversion 04:50:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:50:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:30 INFO - Cleaning up... 04:50:30 INFO - Return code: 0 04:50:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:50: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:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:50:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:50:30 INFO - Using env: {'DISPLAY': ':0', 04:50:30 INFO - 'HOME': '/home/cltbld', 04:50:30 INFO - 'LANG': 'en_US.UTF-8', 04:50:30 INFO - 'LANGUAGE': 'en_US:en', 04:50:30 INFO - 'LOGNAME': 'cltbld', 04:50:30 INFO - 'MAIL': '/var/mail/cltbld', 04:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:30 INFO - 'MOZ_NO_REMOTE': '1', 04:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:30 INFO - 'NO_EM_RESTART': '1', 04:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:30 INFO - 'SHELL': '/bin/bash', 04:50:30 INFO - 'SHLVL': '1', 04:50:30 INFO - 'TERM': 'linux', 04:50:30 INFO - 'TMOUT': '86400', 04:50:30 INFO - 'USER': 'cltbld', 04:50:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:30 INFO - '_': '/tools/buildbot/bin/python'} 04:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50:30 INFO - Running setup.py (path:/tmp/pip-DyXuOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50:31 INFO - Running setup.py (path:/tmp/pip-rm71zw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50:31 INFO - Running setup.py (path:/tmp/pip-Ee44Qm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50:31 INFO - Running setup.py (path:/tmp/pip-MycyVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50:31 INFO - Running setup.py (path:/tmp/pip-wBhwRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50:31 INFO - Running setup.py (path:/tmp/pip-5d0B6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50:31 INFO - Running setup.py (path:/tmp/pip-szW7N7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50:31 INFO - Running setup.py (path:/tmp/pip-F4ScUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50:31 INFO - Running setup.py (path:/tmp/pip-1ldo0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50:31 INFO - Running setup.py (path:/tmp/pip-8mu0dI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:50: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)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:31 INFO - Running setup.py (path:/tmp/pip-DlPUbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:31 INFO - Running setup.py (path:/tmp/pip-aJ_2pf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:31 INFO - Running setup.py (path:/tmp/pip-MkJ9mq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50:31 INFO - Running setup.py (path:/tmp/pip-QiFJ4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:50: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)) 04:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50:32 INFO - Running setup.py (path:/tmp/pip-KTh78m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:50: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)) 04:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:50:32 INFO - Running setup.py (path:/tmp/pip-IST7SO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:50: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)) 04:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50:32 INFO - Running setup.py (path:/tmp/pip-DyzBOU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:33 INFO - Downloading blessings-1.5.1.tar.gz 04:50:33 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:50:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:34 INFO - Installing collected packages: blessings 04:50:34 INFO - Running setup.py install for blessings 04:50:34 INFO - Successfully installed blessings 04:50:34 INFO - Cleaning up... 04:50:34 INFO - Return code: 0 04:50:34 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:50:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:50:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:50:34 INFO - Reading from file tmpfile_stdout 04:50:34 INFO - Current package versions: 04:50:34 INFO - argparse == 1.2.1 04:50:34 INFO - blessings == 1.5.1 04:50:34 INFO - blobuploader == 1.2.4 04:50:34 INFO - docopt == 0.6.1 04:50:34 INFO - manifestparser == 1.1 04:50:34 INFO - mozInstall == 1.12 04:50:34 INFO - mozcrash == 0.16 04:50:34 INFO - mozdebug == 0.1 04:50:34 INFO - mozdevice == 0.47 04:50:34 INFO - mozfile == 1.2 04:50:34 INFO - mozhttpd == 0.7 04:50:34 INFO - mozinfo == 0.9 04:50:34 INFO - mozleak == 0.1 04:50:34 INFO - mozlog == 3.1 04:50:34 INFO - moznetwork == 0.27 04:50:34 INFO - mozprocess == 0.22 04:50:34 INFO - mozprofile == 0.28 04:50:34 INFO - mozrunner == 6.11 04:50:34 INFO - mozscreenshot == 0.1 04:50:34 INFO - mozsystemmonitor == 0.0 04:50:34 INFO - moztest == 0.7 04:50:34 INFO - mozversion == 1.4 04:50:34 INFO - psutil == 3.1.1 04:50:34 INFO - requests == 1.2.3 04:50:34 INFO - wsgiref == 0.1.2 04:50:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:34 INFO - Using env: {'DISPLAY': ':0', 04:50:34 INFO - 'HOME': '/home/cltbld', 04:50:34 INFO - 'LANG': 'en_US.UTF-8', 04:50:34 INFO - 'LANGUAGE': 'en_US:en', 04:50:34 INFO - 'LOGNAME': 'cltbld', 04:50:34 INFO - 'MAIL': '/var/mail/cltbld', 04:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:34 INFO - 'MOZ_NO_REMOTE': '1', 04:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:34 INFO - 'NO_EM_RESTART': '1', 04:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:34 INFO - 'SHELL': '/bin/bash', 04:50:34 INFO - 'SHLVL': '1', 04:50:34 INFO - 'TERM': 'linux', 04:50:34 INFO - 'TMOUT': '86400', 04:50:34 INFO - 'USER': 'cltbld', 04:50:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:34 INFO - '_': '/tools/buildbot/bin/python'} 04:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50: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)) 04:50:34 INFO - Cleaning up... 04:50:34 INFO - Return code: 0 04:50:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:34 INFO - Using env: {'DISPLAY': ':0', 04:50:34 INFO - 'HOME': '/home/cltbld', 04:50:34 INFO - 'LANG': 'en_US.UTF-8', 04:50:34 INFO - 'LANGUAGE': 'en_US:en', 04:50:34 INFO - 'LOGNAME': 'cltbld', 04:50:34 INFO - 'MAIL': '/var/mail/cltbld', 04:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:34 INFO - 'MOZ_NO_REMOTE': '1', 04:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:34 INFO - 'NO_EM_RESTART': '1', 04:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:34 INFO - 'SHELL': '/bin/bash', 04:50:34 INFO - 'SHLVL': '1', 04:50:34 INFO - 'TERM': 'linux', 04:50:34 INFO - 'TMOUT': '86400', 04:50:34 INFO - 'USER': 'cltbld', 04:50:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:34 INFO - '_': '/tools/buildbot/bin/python'} 04:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:34 INFO - Downloading/unpacking jsonschema 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:50: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 04:50:36 INFO - Downloading/unpacking functools32 (from jsonschema) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:50: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 04:50:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:50:36 INFO - warning: no files found matching '*.txt' 04:50:36 INFO - no previously-included directories found matching 'build' 04:50:36 INFO - no previously-included directories found matching 'dist' 04:50:36 INFO - no previously-included directories found matching '.git*' 04:50:36 INFO - Installing collected packages: jsonschema, functools32 04:50:36 INFO - Running setup.py install for functools32 04:50:36 INFO - warning: no files found matching '*.txt' 04:50:36 INFO - no previously-included directories found matching 'build' 04:50:36 INFO - no previously-included directories found matching 'dist' 04:50:36 INFO - no previously-included directories found matching '.git*' 04:50:36 INFO - Successfully installed jsonschema functools32 04:50:36 INFO - Cleaning up... 04:50:37 INFO - Return code: 0 04:50:37 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:50: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')]} 04:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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 0x7fda09f9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, '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': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:50: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 04:50: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 04:50:37 INFO - Using env: {'DISPLAY': ':0', 04:50:37 INFO - 'HOME': '/home/cltbld', 04:50:37 INFO - 'LANG': 'en_US.UTF-8', 04:50:37 INFO - 'LANGUAGE': 'en_US:en', 04:50:37 INFO - 'LOGNAME': 'cltbld', 04:50:37 INFO - 'MAIL': '/var/mail/cltbld', 04:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:37 INFO - 'MOZ_NO_REMOTE': '1', 04:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:37 INFO - 'NO_EM_RESTART': '1', 04:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:37 INFO - 'SHELL': '/bin/bash', 04:50:37 INFO - 'SHLVL': '1', 04:50:37 INFO - 'TERM': 'linux', 04:50:37 INFO - 'TMOUT': '86400', 04:50:37 INFO - 'USER': 'cltbld', 04:50:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:37 INFO - '_': '/tools/buildbot/bin/python'} 04:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:37 INFO - Downloading/unpacking flake8 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:50:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:50:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:50: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 04:50:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:50:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:50:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:50:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:50:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:50:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:50:39 INFO - no previously-included directories found matching 'docs/_build' 04:50:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:50:39 INFO - Running setup.py install for pep8 04:50:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:50:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:50:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:50:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:50:39 INFO - no previously-included directories found matching 'docs/_build' 04:50:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:50:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:50:39 INFO - Cleaning up... 04:50:39 INFO - Return code: 0 04:50:39 INFO - Running post-action listener: _resource_record_post_action 04:50:39 INFO - Running post-action listener: _start_resource_monitoring 04:50:39 INFO - Starting resource monitoring. 04:50:39 INFO - ##### 04:50:39 INFO - ##### Running install step. 04:50:39 INFO - ##### 04:50:39 INFO - Running pre-action listener: _resource_record_pre_action 04:50:39 INFO - Running main action method: install 04:50:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:50:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:50:40 INFO - Reading from file tmpfile_stdout 04:50:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:50:40 INFO - Reading from file tmpfile_stdout 04:50:40 INFO - Output received: 04:50:40 INFO - Usage: mozinstall [options] installer 04:50:40 INFO - Options: 04:50:40 INFO - -h, --help show this help message and exit 04:50:40 INFO - -d DEST, --destination=DEST 04:50:40 INFO - Directory to install application into. [default: 04:50:40 INFO - "/builds/slave/test-pgo"] 04:50:40 INFO - --app=APP Application being installed. [default: firefox] 04:50:40 INFO - mkdir: /builds/slave/test-pgo/build/application 04:50: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'] 04:50: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 04:50:56 INFO - Reading from file tmpfile_stdout 04:50:56 INFO - Output received: 04:50:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:50:56 INFO - Running post-action listener: _resource_record_post_action 04:50:56 INFO - ##### 04:50:56 INFO - ##### Running run-tests step. 04:50:56 INFO - ##### 04:50:56 INFO - Running pre-action listener: _resource_record_pre_action 04:50:56 INFO - Running main action method: run_tests 04:50:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:50:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:50:56 INFO - Python 2.7.3 04:50:56 INFO - Return code: 0 04:50:56 INFO - grabbing minidump binary from tooltool 04:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50: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 0x16ec840>, '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 0x16596b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1659b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:50: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 04:50: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 04:50:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:56 INFO - Return code: 0 04:50:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:50:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:50:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:50:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:50:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:50:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:50:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:50:57 INFO - Return code: 0 04:50: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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:50: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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:50:57 INFO - Using env: {'DISPLAY': ':0', 04:50:57 INFO - 'HOME': '/home/cltbld', 04:50:57 INFO - 'LANG': 'en_US.UTF-8', 04:50:57 INFO - 'LANGUAGE': 'en_US:en', 04:50:57 INFO - 'LOGNAME': 'cltbld', 04:50:57 INFO - 'MAIL': '/var/mail/cltbld', 04:50:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:50:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:57 INFO - 'MOZ_NO_REMOTE': '1', 04:50:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:57 INFO - 'NO_EM_RESTART': '1', 04:50:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:50:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:50:57 INFO - 'SHELL': '/bin/bash', 04:50:57 INFO - 'SHLVL': '1', 04:50:57 INFO - 'TERM': 'linux', 04:50:57 INFO - 'TMOUT': '86400', 04:50:57 INFO - 'USER': 'cltbld', 04:50:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765', 04:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:57 INFO - '_': '/tools/buildbot/bin/python'} 04:50: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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:50:57 INFO - mozversion application_buildid: 20160107023008 04:50:57 INFO - mozversion application_changeset: a236b6aa15d68b434a8eacb2d21aa1f4a27f42f7 04:50:57 INFO - mozversion application_display_name: Nightly 04:50:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:57 INFO - mozversion application_name: Firefox 04:50:57 INFO - mozversion application_remotingname: firefox 04:50:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:50:57 INFO - mozversion application_vendor: Mozilla 04:50:57 INFO - mozversion application_version: 46.0a1 04:50:57 INFO - mozversion platform_buildid: 20160107023008 04:50:57 INFO - mozversion platform_changeset: a236b6aa15d68b434a8eacb2d21aa1f4a27f42f7 04:50:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:50:57 INFO - mozversion platform_version: 46.0a1 04:50:57 INFO - using testdate: 1452171057 04:50:57 INFO - actual date: 1452171057 04:50:57 INFO - starting webserver on 'localhost:41117' 04:50:57 INFO - SUITE-START | Running 3 tests 04:50:57 INFO - TEST-START | dromaeo_css 04:50:57 INFO - operating with platform_type : linux_ 04:50:57 INFO - Initialising browser for dromaeo_css test... 04:50:57 INFO - TEST-INFO | started process 5675 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGOItuG/profile http://localhost:41117/getInfo.html) 04:51:01 INFO - PROCESS | 5675 | __metrics Screen width/height:1600/1200 04:51:01 INFO - PROCESS | 5675 | colorDepth:24 04:51:01 INFO - PROCESS | 5675 | Browser inner width/height: 1024/697 04:51:01 INFO - PROCESS | 5675 | __metrics 04:51:01 INFO - PROCESS | 5675 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:51:01 INFO - PROCESS | 5675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:02 INFO - TEST-INFO | 5675: exit 0 04:51:02 INFO - Browser initialized. 04:51:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:51:02 INFO - TEST-INFO | started process 5768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGOItuG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:14 INFO - PROCESS | 5768 | RSS: Main: 149901312 04:51:14 INFO - PROCESS | 5768 | 04:52:05 INFO - PROCESS | 5768 | 1452171125857 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:54:14 INFO - PROCESS | 5768 | Cycle 1(1): loaded http://localhost:41117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41117/tests/dromaeo/cssquery-ext.html) 04:54:15 INFO - PROCESS | 5768 | RSS: Main: 324694016 04:54:15 INFO - PROCESS | 5768 | 04:57:18 INFO - PROCESS | 5768 | Cycle 1(1): loaded http://localhost:41117/tests/dromaeo/cssquery-ext.html (next: http://localhost:41117/tests/dromaeo/cssquery-jquery.html) 04:57:18 INFO - PROCESS | 5768 | RSS: Main: 243089408 04:57:18 INFO - PROCESS | 5768 | 05:00:20 INFO - PROCESS | 5768 | Cycle 1(1): loaded http://localhost:41117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41117/tests/dromaeo/cssquery-mootools.html) 05:00:21 INFO - PROCESS | 5768 | RSS: Main: 237535232 05:00:21 INFO - PROCESS | 5768 | 05:03:23 INFO - PROCESS | 5768 | Cycle 1(1): loaded http://localhost:41117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41117/tests/dromaeo/cssquery-prototype.html) 05:03:23 INFO - PROCESS | 5768 | RSS: Main: 216662016 05:03:23 INFO - PROCESS | 5768 | 05:06:26 INFO - PROCESS | 5768 | Cycle 1(1): loaded http://localhost:41117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41117/tests/dromaeo/cssquery-yui.html) 05:06:26 INFO - PROCESS | 5768 | RSS: Main: 220319744 05:06:26 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | Cycle 1(1): loaded http://localhost:41117/tests/dromaeo/cssquery-yui.html (next: http://localhost:41117/tests/dromaeo/cssquery-dojo.html) 05:09:29 INFO - PROCESS | 5768 | RSS: Main: 261074944 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | __start_tp_report 05:09:29 INFO - PROCESS | 5768 | _x_x_mozilla_page_load 05:09:29 INFO - PROCESS | 5768 | _x_x_mozilla_page_load_details 05:09:29 INFO - PROCESS | 5768 | |i|pagename|runs| 05:09:29 INFO - PROCESS | 5768 | |0;dojo.html;3097.9690203097966;3185;3239.6760323967605;3240.5301231321473;3271.8200498972556;5036.798528058883;5157.071727089123;5218.634695571307;5244.292020577221;5286.392064912537;5165.483451654833;5176.404713457953;5243.4232234454175;5246.554042906358;5278.47215278472;4693.694909830867;4713.976430117845;4761.381020467335;4801.943572414063;4811.903761924759;4849.296851956464;4861.562459378655;4884.926726099111;4906.53387928148;4911.803527858881;4613.838515651953;4647.907041859144;4745.952540474603;4750.144973904696;4766.285057241407;4767.284907263904;4769.95230047702;4770.928436073462;4777.737224452654;4801.8079276828885;4730.597899178574;4738.83414080509;4751.857444276643;4774.904501909942;4784.0192760484015;4901.2648102784515;5011.198208286657;5018.874528136789;5130.1791713326065;5150.97424512875;5555.3333599967855;5557.805476808292;5563.833085007456;5571.804986825442;5572.693501857396;5429.782808687648;5576.219329293902;5587.38538760736;5595.944040559583;5602.991461536922;5225.007248622787;5229.660072095339;5249.4750524947585;5298.019866324742;5319.9202011969855;5671.546276297886;5681.261436013292;5684.062129748628;5686.60193786431;5689.715514224272;5337.2527846101575;5487.204355368449;5490.231367608538;5491.039068163055;5496.697681627549;5472.699001554953;5475.342958844884;5505.889882202334;5637.633553818989;5680.062789639664;5537.612367134262;5550.69471179089;5558.305211848519;5564.33228012641;5573.108302671634;5509.338879334506;5574.275344205227;5575.888482230333;5577.470140336662;5623.5220006299105;4248.468941382327;4319.07139964909;4332.285172946492;4344.500382455994;4386.342048692722;3831.5976822433245;3860.768353898719;3864.9227015459533;3887.74729642578;3904.9609503905167;5170.40540337866;5171.2501687255135;5176.611754118456;5183.248428977777;5227.529522343008;5454.809081682122;5540.806071787468;5568.638038527482;5571.1086226203615;5573.052581061229;5213.504717051874;5228.215767634809;5237.6071794615555;5239.240310155006;5241.292425522582;4744.240921452551;4769.093872164278;4774.785134668949;4776.665633405698;4815.3017812417;5616.157576363578;5734.340550836624;5734.770609175586;5744.626599271034;5773.191753154478;5591.524720398812;5611.466910643482;5614.410486898817;5617.32592088952;5622.32532096151;5737.311522617146;5745.626534275259;5786.826395208151;5789.189513468202;5789.9710501447225;5320.14877619579;5487.176923461513;5491.423400542885;5494.560435165257;5533.916991245215;5585.832425027255;5587.888242235052;5600.4959553640365;5603.495685388335;5603.859903502445;5385;5409.86475338104;5448.591355648263;5450.400455949922;5451.182322651634;5281.392639846466;5309.177077552986;5336.546393556591;5342;5355.571554275726;5237.816676416307;5238.71187084714;5239.240310155083;5255.684658920477;5284;5289.497497737709;5303.284056652303;5311.176767601028;5347.7593508293;5376.166694162411;5330.520253177233;5380.461953804588;5402.432744561922;5406.648567843077;5444.564434845123 05:09:29 INFO - PROCESS | 5768 | |1;ext.html;524.1796588339249;544.1293929712458;544.6024402186404;561.9968356483678;568.6531215958267;27812.44375112499;28719;35385.46921796172;36013.45979810305;36108;38793.61206387935;39305.803470982675;39310.60689393105;39313;39409.60590394095;8290.626921788504;8425.662973481054;8438.324934005264;8440.19818117281;8445.788855278606;7447.627618619047;7616.847663046736;10045.849312260321;10246.848161886013;10294.691159265234;9953;10145.289829711923;10152.746181345452;10154.796904061914;10174.64388746394;7460.664270107858;7625.046869141357;10098;10324.174066074696;10329.690109296771;7352.816179595499;10137.39175649456;10332.431716255604;10358.63744768937;10367.89632103677;36000.09999750001;36347;36389.27221455582;36498.08754781125;36540;2605.908793192248;2696.44722831819;2835.7873159512915;2852.4009957908866;2974.4051189762135;27092.155323691124;27303.45393092127;27860.303492412648;28398.716012839814;29626.851865740748;3290.9835450822834;3317.170707323169;3436.621971583124;3452.2405070884365;3540.681338679531;261782;263860;264166;264353;265082;52630;58497.41502584919;59851;59933.40066599366;59947;48199.5180048202;65365;66511;66627.33372666308;66749.66625166843;15424.614384640474;15600.141992190538;15742.527724168292;15748.527544173694;15749.685006300038;10572.735681608021;10624.734381640366;10627.468626568641;10636.89363106359;10756.946215268874;19443.708344374845;19699.40901772949;19782;19822;19833.702494462595;7712.190220026929;7737;7899.802504937307;7916.247956444128;8014.519128852171;922.6632279218171;967.9806403871883;994.3685759542598;996.272720913737;1079.5411949921252;28793.7120628791;28897.56653650197;29593.704062959096;31274.84362578218;32399.838000809847;942.5711301357866;1007.2495990487134;1027.5427434791445;1054.915606751458;1057.5188289328337;13682.452701892013;16182.352705891632;16357.83642163587;16419;17142.485725428258;443158;453694;456239;456407;458284;54332.18501722477;55149.44850551443;55173.72413137909;55314.72342638261;55356.44643553594;1315.7829207193524;1341.6511706956067;1352.3035636646937;1354.939027743754;1368.0628769293066;28631.570526442538;29650.406991860473;29833.70166298396;30238.69761302447;30365.544516831822;46373.536264636925;46852.29721554248;46860;46887.062258755315;46956;250996;254536;301474;308324;309036;30191.396172076875;30240;30253.848730757087;30344.393112138074;30389.848050759603;38605;41753.58246417497;41826.37260441157;42719.3592096125;42756.1448771029;35947.28105437929;35984.460233097045;36108.81945590255;36217.09457263589;37102;35512;35580.466293005105;35697;36101.638983609824;36256.63743362533;35092.12269693278;35757;35791.64208357987;35810.10474738153;35857.46213806847;29578.260543486584;32231.516527251642;32578.674213257564;32648;32699.182520437178;24163.347797657858;24563.065646114195;24581;24656.87671561631;24712.876435617705 05:09:29 INFO - PROCESS | 5768 | |2;jquery.html;356.5311615225979;358.7721796659121;362.72432950957267;365.9853605855766;366.95229620149377;13449.26029068401;13786;16320.75518867218;16435.4247601334;16950.491485255432;14434.5669629911;15687.45093921713;16131;16134.83865161351;16193;5335.7865685372535;5416.972915135439;5477.370102438211;5478.178273259023;5484.040292948718;4057.6145266199665;4169.916601667965;5403.2705584745945;5434.103372943459;5886.352501224862;5976.581639285252;5987.790427335044;5990.880182396371;6040.0939859021055;6041.4562689357945;5879.647221166722;6042.063480160582;6052.455279024909;6056.152138700608;6058.121572372025;5308.893822123536;5322.0686379883755;5325.733713314357;5332.226827110087;5333.466653334674;19469.805301947083;20368.490787730276;20411.387658370124;20629.4842628934;20888.582228355346;1952.4142757172792;1981.3857704111626;1985.642584334819;2087.8642888212216;2144.356692992096;11920.761584768255;11933.522659093625;12081.395930203542;12392;12535.18521296122;1630.1034431062867;1635.5420482264985;1659.6846599146245;1667.5247554446923;1680.8137634579048;57310.713446433336;57380.139297910566;60284.397156028754;60477.395226047614;61122.694386527786;9333.953330233442;9628.66299679522;9788.902110978941;9798.118169364649;9857.704268871945;12943.870561294454;12952.481900723866;12963.351832408342;12981.805272920914;12991.740165196643;7362.889556656654;7405;7411.0736157980255;7485.176630570633;7541.095068591694;7225.277472252733;7228.530145540523;7238.312360325761;7344.669489872968;7397.778066658009;4294.677899157513;4375.124975005012;4385.210662080793;4388.188185185751;4415.315626077963;1632.9101899395648;1640.3520609359236;1647.3739978808217;1668.457751230855;1679.7984241890806;849.4181485682204;857.4940784936792;866.618687777376;923.7275003873873;961.1589858873485;14680.366209570962;15454.459093931659;15493.14787686688;16320.265588048565;17200.82799171992;909.4134283387178;917.857732051533;956.8660387545749;970.6893793985856;986.5511192407438;9497.955224925252;9864.95067524672;9865.358751681119;9886.258530610234;9890.20878329732;555224;555817;561851;570436;577746;78107.60946195232;79753;82161.17838821655;82167;82870;1157.1090260499368;1159.8898104680043;1166.5158959031908;1169.2516789254714;1175.189119507537;15233.619159520656;15337.539873803804;15350.692986139991;15458.922705386402;15494.612634683772;35139.47290790589;35378.292434151685;35587.82206088953;36171.45742813807;36825.81587092047;45907.770461147484;46423;47677.28484072811;48496.5150348492;50228.748856255486;9388.906110938804;9526.90473095288;9612.567434465605;9630.133288004114;9648.662296819577;13465.528706495226;17162.141892905554;17196.054217018183;17440.302387904343;17671.116444178;11083.72290692739;11612.88387116118;13790.310484475936;14167.504137355143;14579;13859.722805543632;14199.64500887486;14379.856201437851;14640.414383424544;14869.107853528823;11039;11410.258333208647;13188.472461101448;13977.301134943009;14378.065425747292;9219.907800921905;9321.580528876353;9328.440293582407;9345.766355841159;9346.018668039758;13385.799213011618;13429.395677194354;13549;13792.379342929793;14043 05:09:29 INFO - PROCESS | 5768 | |3;mootools.html;1272.281161143953;1481.0595272002279;1482.7182835261299;1642.7125253080708;1818.5817262029732;6754.831129221766;7273.963630181848;7421.962890185541;7426.777196684095;7437.516561423504;7298.744543940963;7452.06849143857;7465.51474154181;7478.326950574461;7486.812829679247;1999.3602047344855;2042.5710600773782;2106.536561956367;2140.218820130649;2213.1700612270397;2254.5378197469563;2259.378670865517;2260.8756518391483;2263.4907145892207;2264.762199969004;2164.8159906407973;2233.3746550965675;2234.329701089675;2235.508188198602;2235.519363336882;2213.5462230242842;2231.776822317763;2252.054137262354;2267.251806903718;2273.147569661377;2264.275431861805;2267.478479949621;2295.414669259345;2303.9539209215723;2304.0898844956314;7319.890201646979;7418.740344087985;7418.962905185494;7421.369183619398;7431.219721929174;4458.509563947963;4543.45478542577;4574.039451715111;4583.656225783079;4588.24293991491;2881.3516958684127;2931.2818359501844;2936.8384738839354;2941.102963596102;3091.196288964863;986.6842610364686;1001.9949900250452;1007.2848277722826;1031.8761748590143;1031.9019693129142;10618.52216650245;10639.308444951053;10662;10673.466326683634;10681.145508359312;4107.260693075275;4166.291730405838;4177.728447650893;4177.874663760092;4243.342281946303;8986.281097512183;9028.458292502472;9048.41185322965;9049.638014479478;9073.31950103745;4598.126355992351;4614.74618895964;4650.116477869194;4660.13787449323;4662.323963025342;4214.7892605370225;4218.915621687549;4227.196832601796;4249.022724773319;4264.232438161161;3315.801051936843;3362.7814192077435;3536.929261414757;3551.254236610289;3619.6561326673923;1162.8197629367462;1168.2990205876406;1185.6028230542865;1193.254216114928;1194.6475789642077;1033.5917312661456;1034.1158309645145;1087.3095584304024;1184.1296646964474;1339.0158233698223;7000.844860598047;7061.89407158893;7095.9645201773665;7193.89209161863;7198.460115491359;1093.6937657455926;1097.2812807611028;1111.216592302425;1129.8305254211934;1132.2583707671488;5696.8006119785605;5780.277465316835;5790;5798.130280457881;5801.622894511843;9197.356185066981;9347.392419492711;9351.438913665203;9366.718998429922;9369.203617692436;9087.318451116193;9114.40756350835;9225.354225204306;9243.861342079874;9251.121143491358;7409.592472413961;7475.514091583921;7485.326320631169;7525.924740752523;7560.206178351194;6996;7007.754728584475;7024.051753013277;7036.648167591702;7038.824029399306;8374.330053595575;8377.748667539983;8383.874241886499;8390.580470976305;8591.31269498426;8771.16673915977;8780;8788.38481306328;8788.824223515621;8796.428232164888;6562.671866406756;6645.933540664531;6676.365745254193;6689.732410703712;6691.197056353269;6457.289698133295;6599.340065993362;6894.896576551256;7099.964500177673;7114.9288507116335;6293.905591416041;6392.977123660192;6804.319568043156;6908.930910690829;6979.267176946348;6727.663616819237;6782.966085169543;6825.590464572141;6900.068490753684;6914.377706006484;6578.276389597045;6638.137042184485;6647.933520664731;6653.334666533308;6654;5912.408759124225;5925.259342582177;5932.733027013881;5954.345022047658;5976.043832986701;6297.2128483939505;6329.588576742497;6329.588576742497;6330.683465826783;6338.683065846782 05:09:29 INFO - PROCESS | 5768 | |4;prototype.html;338.97627166098374;345.04250704295595;347.829563513878;350.73869966874673;351.3657847585108;5715.657060576368;5790.10253410721;5904.321003084636;5934.228550288467;5939.406059394064;5659.915101273474;5770.249867517227;5772.682502462363;5784.768609255625;5793.768249270024;4511.255642818931;4511.458624965009;4513.616342610882;4517.932231016537;4520.841770538023;4333.978330108361;4404.669649776263;4411.095725376306;4415.955840441603;4542.318652202163;4390.692651514395;4452.465704115511;4460.754658493782;4466.642668586522;4475.3063275192235;4447.17727220462;4449.977750111245;4453.710508816916;4456.576625220631;4470.932936005946;3895.435161901537;3900.590438003997;3904.06302487401;3914.725969182158;3916.5691773904846;5378.650387724785;5461.617686761928;5518.227448157261;5527.834164975057;5538.363088244822;5152.252923326134;5152.6650767699975;5165.483451654842;5174.068667639824;5174.146265866128;6117.816465506042;6129.448349648508;6133.478654314388;6133.693315334215;6141.938580614182;4324.13517296542;4324.308110702304;4331.285337919239;4331.740095594275;4339.696221264513;6260.812175634693;6306.1171435998995;6433.613983160979;6440.130582371414;6445.903311450285;4427.535108813592;4433.490148632884;4438.7114837535455;4438.733675979452;4442.666799990014;4483.237849565582;4486.1252055849445;4489.034857505652;4492.303692927601;4492.73043617384;5045.318881950963;5150.381954165524;5151.6136289778415;5163.328767260307;5165.251038599382;6164.969175154185;6165.383461653799;6175.876482470326;6178.969105154445;6190.628562286277;1571.6306667933027;1594.2666373468103;1595.1864549079821;1596.106180538902;1598.79215701958;1076.9569217231224;1083.3608171179042;1083.653230966099;1099.455769394155;1108.661858133261;5877.941220587825;5888.175655408247;5888.558358123158;5889.322727886262;5898.4101589840675;6168.691565421711;6319.304876463585;6319.96840015797;6362.681865906686;6372.745090196433;5657.796937713675;5799.2460980073165;5845.152452894306;5847.912281315784;5861.941380586225;3376.122208225879;3409.454487282023;3410.6248312685584;3413.5050417689795;3414.6926776590226;6593.175853018372;6692.096566963398;6697.162854643169;6699.464042876656;6700.296468870796;6610.504212184105;6612.471002319803;6614.768483103068;6615.735370585219;6616.768413105518;6553.770618028346;6670.433013193933;6679.499037572202;6693.096431981718;6697.966510167418;6419.935800642121;6425.1968503937005;6426.389492998158;6432.839179020562;6434.099226108442;6325.399087086719;6363.268224154096;6368.42684158428;6369.777057802955;6372.458341040878;6540.705668245036;6675.332466753286;6677.732890684319;6683.064370987969;6690.69891854858;4584.106099310736;4595.701279416827;4596.770161491845;4598.517155698603;4604.447466304065;6414.486841052798;6417.358264173546;6422.42198202164;6422.550421470639;6428.228612566335;6116.3883611638485;6264.154339164154;6281.340459251713;6285.49716022708;6292.370762923671;6236.6258024518675;6252.781152659635;6261.96869015652;6263.342349053284;6271.78048768291;6163.7842675506145;6164.753409863555;6169.598976066542;6169.84575385601;6178.9382106180165;6172.537059720628;6319.873602528016;6321.431071203614;6322.36776322364;6329.113924050729;5927.614705044159;6071.574989750852;6164.753409863734;6173.6913154343;6174.289956655042 05:09:29 INFO - PROCESS | 5768 | |5;yui.html;734.7832389445114;840.5293035899897;846.8941382327209;863.6977058029694;868.4789126524084;13592.184468931871;13791.034627576073;13818.447262109528;13847.37686804095;13848.376823042961;12828.80756788649;12947.805782913263;13025.804612930813;13058.412371443284;13186.802197967038;821.5892053973014;832.0182185021672;834.7287131682198;836.5022811427222;838.4089217101958;822.9177082291783;823.6458322921142;824.1552408780988;824.3116997307226;825.1253671108614;848.2832006954114;859.8925134358205;862.4738909265343;872.3457406944791;873.8077622922947;854.1159899504046;864.6325311742485;866.2593482572436;867.1242045534025;867.2151702709058;627.5230824573312;634.926983396906;635.6122765113278;635.7012204263989;636.1983900285627;11771.529138834436;11838.112141589416;11940.940295298555;11942.522299108025;11969.521219151224;9815.607375704963;10024.147947424404;10066.547005384775;10676.145908327315;11024.724381890517;9292;9299.163075323253;9312.580933857993;9368.4378937264;9441.622335106587;3420.6579342065843;3471.7049050830456;3503.1942653189653;3507.8947631571095;3581.3195492856535;41339;41938.37092443616;45829.77085114553;45872;46295.30557041613;9333.859992100124;9504.619815207452;9529.428234305826;9708.708738737849;9721.027897210222;17886.910565447088;17970.91014544919;18029.098545072695;18036.819631803777;18045;7407.407407407502;7446.34948345721;7541.472096953161;7587.393008559302;7609.961950190324;4293.5706429356815;4383.802728877208;4420.138073075784;4508.616767574727;4517.186906356887;2890.7831912606216;2920.7663386928994;2936.9867395748433;2939.2798764302456;2942.8822847085876;506.8023470846373;509.1827616675257;524.404800551377;530.3582664975346;537.0065379048729;543.8531596468931;558.4080874273284;589.8997170481028;594.3610618585038;672.7779832655212;8224.547649879314;8376.916230837614;8472.788180295542;8740.213380795632;9290.674826381044;541.2882060090968;569.9743511541991;605.5337390209514;675.4866301610812;699.1226011355818;3673.3020726061964;3845.538535375773;3886.055653511688;3945.6054394560315;3985;54913.725431372586;54958.45041549533;55299.44700552943;55621;56136;50530.74734626304;50893.49106508888;51173;51475;51497.48502514927;42127;46220.76889615531;49740.50259497359;50202.49797502051;55734.72132639311;8608.74639058017;8786.297096232158;8791.285247140097;8855.291576673979;9227.76930576741;31750.523742143425;31868;35137.824310878284;36135.91592252236;36537.451938220416;45124;45150.484951504586;45875.541244587126;46681.76659116683;50003.749981249865;11989.880101199225;12195.329256890956;12299.139060265696;12338.81491777606;12468.064895133082;12664.430100645308;12936.965042796743;13039.413226405024;13048.739025219633;13345.16925701463;10893.346399215756;11064.944675276573;11761.705957351134;12141.271523708605;12186.87813121893;11510.59712910044;11828.112891533341;11853.407329633656;11922.940385298365;12258.141930065167;11267.830982535432;11680.123990700902;11731.941340293244;11818.172727909308;12066.034717222778;10251.58993640246;10291.897081029094;10487.423191724529;10647.680569582924;10768.3538987661;9054.27565794748;9142.26861851037;9326.160645541933;9517.762055948657;9687.41875487473 05:09:29 INFO - PROCESS | 5768 | __end_tp_report 05:09:29 INFO - PROCESS | 5768 | __start_cc_report 05:09:29 INFO - PROCESS | 5768 | _x_x_mozilla_cycle_collect,1483 05:09:29 INFO - PROCESS | 5768 | __end_cc_report 05:09:29 INFO - PROCESS | 5768 | __startTimestamp1452172169759__endTimestamp 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | ------- Summary: start ------- 05:09:29 INFO - PROCESS | 5768 | Number of tests: 6 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | [#0] dojo.html Cycles:165 Average:5168.80 Median:5309.18 stddev:548.10 (10.3%) stddev-sans-first:525.15 05:09:29 INFO - PROCESS | 5768 | Values: 3098.0 3185.0 3239.7 3240.5 3271.8 5036.8 5157.1 5218.6 5244.3 5286.4 5165.5 5176.4 5243.4 5246.6 5278.5 4693.7 4714.0 4761.4 4801.9 4811.9 4849.3 4861.6 4884.9 4906.5 4911.8 4613.8 4647.9 4746.0 4750.1 4766.3 4767.3 4770.0 4770.9 4777.7 4801.8 4730.6 4738.8 4751.9 4774.9 4784.0 4901.3 5011.2 5018.9 5130.2 5151.0 5555.3 5557.8 5563.8 5571.8 5572.7 5429.8 5576.2 5587.4 5595.9 5603.0 5225.0 5229.7 5249.5 5298.0 5319.9 5671.5 5681.3 5684.1 5686.6 5689.7 5337.3 5487.2 5490.2 5491.0 5496.7 5472.7 5475.3 5505.9 5637.6 5680.1 5537.6 5550.7 5558.3 5564.3 5573.1 5509.3 5574.3 5575.9 5577.5 5623.5 4248.5 4319.1 4332.3 4344.5 4386.3 3831.6 3860.8 3864.9 3887.7 3905.0 5170.4 5171.3 5176.6 5183.2 5227.5 5454.8 5540.8 5568.6 5571.1 5573.1 5213.5 5228.2 5237.6 5239.2 5241.3 4744.2 4769.1 4774.8 4776.7 4815.3 5616.2 5734.3 5734.8 5744.6 5773.2 5591.5 5611.5 5614.4 5617.3 5622.3 5737.3 5745.6 5786.8 5789.2 5790.0 5320.1 5487.2 5491.4 5494.6 5533.9 5585.8 5587.9 5600.5 5603.5 5603.9 5385.0 5409.9 5448.6 5450.4 5451.2 5281.4 5309.2 5336.5 5342.0 5355.6 5237.8 5238.7 5239.2 5255.7 5284.0 5289.5 5303.3 5311.2 5347.8 5376.2 5330.5 5380.5 5402.4 5406.6 5444.6 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | [#1] ext.html Cycles:180 Average:49552.73 Median:17995.08 stddev:91176.73 (506.7%) stddev-sans-first:91358.20 05:09:29 INFO - PROCESS | 5768 | Values: 524.2 544.1 544.6 562.0 568.7 27812.4 28719.0 35385.5 36013.5 36108.0 38793.6 39305.8 39310.6 39313.0 39409.6 8290.6 8425.7 8438.3 8440.2 8445.8 7447.6 7616.8 10045.8 10246.8 10294.7 9953.0 10145.3 10152.7 10154.8 10174.6 7460.7 7625.0 10098.0 10324.2 10329.7 7352.8 10137.4 10332.4 10358.6 10367.9 36000.1 36347.0 36389.3 36498.1 36540.0 2605.9 2696.4 2835.8 2852.4 2974.4 27092.2 27303.5 27860.3 28398.7 29626.9 3291.0 3317.2 3436.6 3452.2 3540.7 261782.0 263860.0 264166.0 264353.0 265082.0 52630.0 58497.4 59851.0 59933.4 59947.0 48199.5 65365.0 66511.0 66627.3 66749.7 15424.6 15600.1 15742.5 15748.5 15749.7 10572.7 10624.7 10627.5 10636.9 10756.9 19443.7 19699.4 19782.0 19822.0 19833.7 7712.2 7737.0 7899.8 7916.2 8014.5 922.7 968.0 994.4 996.3 1079.5 28793.7 28897.6 29593.7 31274.8 32399.8 942.6 1007.2 1027.5 1054.9 1057.5 13682.5 16182.4 16357.8 16419.0 17142.5 443158.0 453694.0 456239.0 456407.0 458284.0 54332.2 55149.4 55173.7 55314.7 55356.4 1315.8 1341.7 1352.3 1354.9 1368.1 28631.6 29650.4 29833.7 30238.7 30365.5 46373.5 46852.3 46860.0 46887.1 46956.0 250996.0 254536.0 301474.0 308324.0 309036.0 30191.4 30240.0 30253.8 30344.4 30389.8 38605.0 41753.6 41826.4 42719.4 42756.1 35947.3 35984.5 36108.8 36217.1 37102.0 35512.0 35580.5 35697.0 36101.6 36256.6 35092.1 35757.0 35791.6 35810.1 35857.5 29578.3 32231.5 32578.7 32648.0 32699.2 24163.3 24563.1 24581.0 24656.9 24712.9 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | [#2] jquery.html Cycles:180 Average:29453.16 Median:4113.77 stddev:92182.56 (2240.8%) stddev-sans-first:92415.26 05:09:29 INFO - PROCESS | 5768 | Values: 356.5 358.8 362.7 366.0 367.0 13449.3 13786.0 16320.8 16435.4 16950.5 14434.6 15687.5 16131.0 16134.8 16193.0 5335.8 5417.0 5477.4 5478.2 5484.0 4057.6 4169.9 5403.3 5434.1 5886.4 5976.6 5987.8 5990.9 6040.1 6041.5 5879.6 6042.1 6052.5 6056.2 6058.1 5308.9 5322.1 5325.7 5332.2 5333.5 19469.8 20368.5 20411.4 20629.5 20888.6 1952.4 1981.4 1985.6 2087.9 2144.4 11920.8 11933.5 12081.4 12392.0 12535.2 1630.1 1635.5 1659.7 1667.5 1680.8 57310.7 57380.1 60284.4 60477.4 61122.7 9334.0 9628.7 9788.9 9798.1 9857.7 12943.9 12952.5 12963.4 12981.8 12991.7 7362.9 7405.0 7411.1 7485.2 7541.1 7225.3 7228.5 7238.3 7344.7 7397.8 4294.7 4375.1 4385.2 4388.2 4415.3 1632.9 1640.4 1647.4 1668.5 1679.8 849.4 857.5 866.6 923.7 961.2 14680.4 15454.5 15493.1 16320.3 17200.8 909.4 917.9 956.9 970.7 986.6 9498.0 9865.0 9865.4 9886.3 9890.2 555224.0 555817.0 561851.0 570436.0 577746.0 78107.6 79753.0 82161.2 82167.0 82870.0 1157.1 1159.9 1166.5 1169.3 1175.2 15233.6 15337.5 15350.7 15458.9 15494.6 35139.5 35378.3 35587.8 36171.5 36825.8 45907.8 46423.0 47677.3 48496.5 50228.7 9388.9 9526.9 9612.6 9630.1 9648.7 13465.5 17162.1 17196.1 17440.3 17671.1 11083.7 11612.9 13790.3 14167.5 14579.0 13859.7 14199.6 14379.9 14640.4 14869.1 11039.0 11410.3 13188.5 13977.3 14378.1 9219.9 9321.6 9328.4 9345.8 9346.0 13385.8 13429.4 13549.0 13792.4 14043.0 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | [#3] mootools.html Cycles:180 Average:5331.31 Median:5929.00 stddev:2775.82 (46.8%) stddev-sans-first:2766.83 05:09:29 INFO - PROCESS | 5768 | Values: 1272.3 1481.1 1482.7 1642.7 1818.6 6754.8 7274.0 7422.0 7426.8 7437.5 7298.7 7452.1 7465.5 7478.3 7486.8 1999.4 2042.6 2106.5 2140.2 2213.2 2254.5 2259.4 2260.9 2263.5 2264.8 2164.8 2233.4 2234.3 2235.5 2235.5 2213.5 2231.8 2252.1 2267.3 2273.1 2264.3 2267.5 2295.4 2304.0 2304.1 7319.9 7418.7 7419.0 7421.4 7431.2 4458.5 4543.5 4574.0 4583.7 4588.2 2881.4 2931.3 2936.8 2941.1 3091.2 986.7 1002.0 1007.3 1031.9 1031.9 10618.5 10639.3 10662.0 10673.5 10681.1 4107.3 4166.3 4177.7 4177.9 4243.3 8986.3 9028.5 9048.4 9049.6 9073.3 4598.1 4614.7 4650.1 4660.1 4662.3 4214.8 4218.9 4227.2 4249.0 4264.2 3315.8 3362.8 3536.9 3551.3 3619.7 1162.8 1168.3 1185.6 1193.3 1194.6 1033.6 1034.1 1087.3 1184.1 1339.0 7000.8 7061.9 7096.0 7193.9 7198.5 1093.7 1097.3 1111.2 1129.8 1132.3 5696.8 5780.3 5790.0 5798.1 5801.6 9197.4 9347.4 9351.4 9366.7 9369.2 9087.3 9114.4 9225.4 9243.9 9251.1 7409.6 7475.5 7485.3 7525.9 7560.2 6996.0 7007.8 7024.1 7036.6 7038.8 8374.3 8377.7 8383.9 8390.6 8591.3 8771.2 8780.0 8788.4 8788.8 8796.4 6562.7 6645.9 6676.4 6689.7 6691.2 6457.3 6599.3 6894.9 7100.0 7114.9 6293.9 6393.0 6804.3 6908.9 6979.3 6727.7 6783.0 6825.6 6900.1 6914.4 6578.3 6638.1 6647.9 6653.3 6654.0 5912.4 5925.3 5932.7 5954.3 5976.0 6297.2 6329.6 6329.6 6330.7 6338.7 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | [#4] prototype.html Cycles:180 Average:5194.27 Median:5854.93 stddev:1557.61 (26.6%) stddev-sans-first:1518.75 05:09:29 INFO - PROCESS | 5768 | Values: 339.0 345.0 347.8 350.7 351.4 5715.7 5790.1 5904.3 5934.2 5939.4 5659.9 5770.2 5772.7 5784.8 5793.8 4511.3 4511.5 4513.6 4517.9 4520.8 4334.0 4404.7 4411.1 4416.0 4542.3 4390.7 4452.5 4460.8 4466.6 4475.3 4447.2 4450.0 4453.7 4456.6 4470.9 3895.4 3900.6 3904.1 3914.7 3916.6 5378.7 5461.6 5518.2 5527.8 5538.4 5152.3 5152.7 5165.5 5174.1 5174.1 6117.8 6129.4 6133.5 6133.7 6141.9 4324.1 4324.3 4331.3 4331.7 4339.7 6260.8 6306.1 6433.6 6440.1 6445.9 4427.5 4433.5 4438.7 4438.7 4442.7 4483.2 4486.1 4489.0 4492.3 4492.7 5045.3 5150.4 5151.6 5163.3 5165.3 6165.0 6165.4 6175.9 6179.0 6190.6 1571.6 1594.3 1595.2 1596.1 1598.8 1077.0 1083.4 1083.7 1099.5 1108.7 5877.9 5888.2 5888.6 5889.3 5898.4 6168.7 6319.3 6320.0 6362.7 6372.7 5657.8 5799.2 5845.2 5847.9 5861.9 3376.1 3409.5 3410.6 3413.5 3414.7 6593.2 6692.1 6697.2 6699.5 6700.3 6610.5 6612.5 6614.8 6615.7 6616.8 6553.8 6670.4 6679.5 6693.1 6698.0 6419.9 6425.2 6426.4 6432.8 6434.1 6325.4 6363.3 6368.4 6369.8 6372.5 6540.7 6675.3 6677.7 6683.1 6690.7 4584.1 4595.7 4596.8 4598.5 4604.4 6414.5 6417.4 6422.4 6422.6 6428.2 6116.4 6264.2 6281.3 6285.5 6292.4 6236.6 6252.8 6262.0 6263.3 6271.8 6163.8 6164.8 6169.6 6169.8 6178.9 6172.5 6319.9 6321.4 6322.4 6329.1 5927.6 6071.6 6164.8 6173.7 6174.3 05:09:29 INFO - PROCESS | 5768 | 05:09:29 INFO - PROCESS | 5768 | [#5] yui.html Cycles:180 Average:13691.60 Median:49872.13 stddev:15819.33 (31.7%) stddev-sans-first:15833.78 05:09:29 INFO - PROCESS | 5768 | Values: 734.8 840.5 846.9 863.7 868.5 13592.2 13791.0 13818.4 13847.4 13848.4 12828.8 12947.8 13025.8 13058.4 13186.8 821.6 832.0 834.7 836.5 838.4 822.9 823.6 824.2 824.3 825.1 848.3 859.9 862.5 872.3 873.8 854.1 864.6 866.3 867.1 867.2 627.5 634.9 635.6 635.7 636.2 11771.5 11838.1 11940.9 11942.5 11969.5 9815.6 10024.1 10066.5 10676.1 11024.7 9292.0 9299.2 9312.6 9368.4 9441.6 3420.7 3471.7 3503.2 3507.9 3581.3 41339.0 41938.4 45829.8 45872.0 46295.3 9333.9 9504.6 9529.4 9708.7 9721.0 17886.9 17970.9 18029.1 18036.8 18045.0 7407.4 7446.3 7541.5 7587.4 7610.0 4293.6 4383.8 4420.1 4508.6 4517.2 2890.8 2920.8 2937.0 2939.3 2942.9 506.8 509.2 524.4 530.4 537.0 543.9 558.4 589.9 594.4 672.8 8224.5 8376.9 8472.8 8740.2 9290.7 541.3 570.0 605.5 675.5 699.1 3673.3 3845.5 3886.1 3945.6 3985.0 54913.7 54958.5 55299.4 55621.0 56136.0 50530.7 50893.5 51173.0 51475.0 51497.5 42127.0 46220.8 49740.5 50202.5 55734.7 8608.7 8786.3 8791.3 8855.3 9227.8 31750.5 31868.0 35137.8 36135.9 36537.5 45124.0 45150.5 45875.5 46681.8 50003.7 11989.9 12195.3 12299.1 12338.8 12468.1 12664.4 12937.0 13039.4 13048.7 13345.2 10893.3 11064.9 11761.7 12141.3 12186.9 11510.6 11828.1 11853.4 11922.9 12258.1 11267.8 11680.1 11731.9 11818.2 12066.0 10251.6 10291.9 10487.4 10647.7 10768.4 9054.3 9142.3 9326.2 9517.8 9687.4 05:09:29 INFO - PROCESS | 5768 | -------- Summary: end -------- 05:09:29 INFO - PROCESS | 5768 | 05:09:30 INFO - TEST-INFO | 5768: exit 0 05:09:30 INFO - TEST-OK | dromaeo_css | took 1113217ms 05:09:30 INFO - TEST-START | kraken 05:09:30 INFO - operating with platform_type : linux_ 05:09:30 INFO - Initialising browser for kraken test... 05:09:30 INFO - TEST-INFO | started process 5958 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpObDoAz/profile http://localhost:41117/getInfo.html) 05:09:34 INFO - PROCESS | 5958 | __metrics Screen width/height:1600/1200 05:09:34 INFO - PROCESS | 5958 | colorDepth:24 05:09:34 INFO - PROCESS | 5958 | Browser inner width/height: 1024/697 05:09:34 INFO - PROCESS | 5958 | __metrics 05:09:34 INFO - PROCESS | 5958 | 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:09:34 INFO - PROCESS | 5958 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:35 INFO - TEST-INFO | 5958: exit 0 05:09:35 INFO - Browser initialized. 05:09:35 INFO - Running cycle 1/1 for kraken test... 05:09:35 INFO - TEST-INFO | started process 6042 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpObDoAz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:47 INFO - PROCESS | 6042 | RSS: Main: 150171648 05:09:47 INFO - PROCESS | 6042 | 05:09:50 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41117/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:50 INFO - PROCESS | 6042 | RSS: Main: 184639488 05:09:50 INFO - PROCESS | 6042 | 05:09:53 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41117/tests/kraken/driver.html?testName=audio-dft) 05:09:53 INFO - PROCESS | 6042 | RSS: Main: 174211072 05:09:53 INFO - PROCESS | 6042 | 05:09:56 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41117/tests/kraken/driver.html?testName=audio-fft) 05:09:57 INFO - PROCESS | 6042 | RSS: Main: 160497664 05:09:57 INFO - PROCESS | 6042 | 05:09:59 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41117/tests/kraken/driver.html?testName=audio-oscillator) 05:09:59 INFO - PROCESS | 6042 | RSS: Main: 161513472 05:09:59 INFO - PROCESS | 6042 | 05:10:02 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:10:02 INFO - PROCESS | 6042 | RSS: Main: 164810752 05:10:02 INFO - PROCESS | 6042 | 05:10:05 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41117/tests/kraken/driver.html?testName=imaging-darkroom) 05:10:06 INFO - PROCESS | 6042 | RSS: Main: 163971072 05:10:06 INFO - PROCESS | 6042 | 05:10:09 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41117/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:10 INFO - PROCESS | 6042 | RSS: Main: 166440960 05:10:10 INFO - PROCESS | 6042 | 05:10:12 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41117/tests/kraken/driver.html?testName=json-parse-financial) 05:10:13 INFO - PROCESS | 6042 | RSS: Main: 165568512 05:10:13 INFO - PROCESS | 6042 | 05:10:14 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:15 INFO - PROCESS | 6042 | RSS: Main: 178061312 05:10:15 INFO - PROCESS | 6042 | 05:10:17 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:17 INFO - PROCESS | 6042 | RSS: Main: 176410624 05:10:17 INFO - PROCESS | 6042 | 05:10:19 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:20 INFO - PROCESS | 6042 | RSS: Main: 181600256 05:10:20 INFO - PROCESS | 6042 | 05:10:22 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:23 INFO - PROCESS | 6042 | RSS: Main: 190808064 05:10:23 INFO - PROCESS | 6042 | 05:10:26 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:26 INFO - PROCESS | 6042 | RSS: Main: 187232256 05:10:26 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | Cycle 1(1): loaded http://localhost:41117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41117/tests/kraken/driver.html?testName=ai-astar) 05:10:28 INFO - PROCESS | 6042 | RSS: Main: 244953088 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | __start_tp_report 05:10:28 INFO - PROCESS | 6042 | _x_x_mozilla_page_load 05:10:28 INFO - PROCESS | 6042 | _x_x_mozilla_page_load_details 05:10:28 INFO - PROCESS | 6042 | |i|pagename|runs| 05:10:28 INFO - PROCESS | 6042 | |0;ai-astar;110;112;105;109;109;109;99;109;110;111 05:10:28 INFO - PROCESS | 6042 | |1;audio-beat-detection;153;125;147;169;124;153;156;132;169;127 05:10:28 INFO - PROCESS | 6042 | |2;audio-dft;161;159;160;162;161;161;161;162;161;161 05:10:28 INFO - PROCESS | 6042 | |3;audio-fft;75;71;87;102;75;74;75;100;89;71 05:10:28 INFO - PROCESS | 6042 | |4;audio-oscillator;95;97;144;95;96;96;135;95;96;143 05:10:28 INFO - PROCESS | 6042 | |5;imaging-gaussian-blur;109;110;110;109;109;110;110;109;109;110 05:10:28 INFO - PROCESS | 6042 | |6;imaging-darkroom;145;145;146;146;146;145;146;147;146;145 05:10:28 INFO - PROCESS | 6042 | |7;imaging-desaturate;95;95;96;96;96;95;96;95;96;96 05:10:28 INFO - PROCESS | 6042 | |8;json-parse-financial;58;57;57;57;58;58;58;58;59;56 05:10:28 INFO - PROCESS | 6042 | |9;json-stringify-tinderbox;67;69;67;68;69;69;68;67;67;68 05:10:28 INFO - PROCESS | 6042 | |10;stanford-crypto-aes;86;85;85;85;85;84;86;86;86;88 05:10:28 INFO - PROCESS | 6042 | |11;stanford-crypto-ccm;123;117;117;122;123;120;120;115;123;117 05:10:28 INFO - PROCESS | 6042 | |12;stanford-crypto-pbkdf2;142;152;151;149;150;142;151;149;150;140 05:10:28 INFO - PROCESS | 6042 | |13;stanford-crypto-sha256-iterative;72;68;76;68;68;67;68;67;68;67 05:10:28 INFO - PROCESS | 6042 | __end_tp_report 05:10:28 INFO - PROCESS | 6042 | __start_cc_report 05:10:28 INFO - PROCESS | 6042 | _x_x_mozilla_cycle_collect,931 05:10:28 INFO - PROCESS | 6042 | __end_cc_report 05:10:28 INFO - PROCESS | 6042 | __startTimestamp1452172228650__endTimestamp 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | ------- Summary: start ------- 05:10:28 INFO - PROCESS | 6042 | Number of tests: 14 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.92 05:10:28 INFO - PROCESS | 6042 | Values: 110.0 112.0 105.0 109.0 109.0 109.0 99.0 109.0 110.0 111.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.00 stddev:17.44 (11.4%) stddev-sans-first:18.28 05:10:28 INFO - PROCESS | 6042 | Values: 153.0 125.0 147.0 169.0 124.0 153.0 156.0 132.0 169.0 127.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 05:10:28 INFO - PROCESS | 6042 | Values: 161.0 159.0 160.0 162.0 161.0 161.0 161.0 162.0 161.0 161.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:11.79 (15.7%) stddev-sans-first:12.24 05:10:28 INFO - PROCESS | 6042 | Values: 75.0 71.0 87.0 102.0 75.0 74.0 75.0 100.0 89.0 71.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.50 stddev:21.85 (22.9%) stddev-sans-first:22.56 05:10:28 INFO - PROCESS | 6042 | Values: 95.0 97.0 144.0 95.0 96.0 96.0 135.0 95.0 96.0 143.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:10:28 INFO - PROCESS | 6042 | Values: 109.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:10:28 INFO - PROCESS | 6042 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:10:28 INFO - PROCESS | 6042 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 05:10:28 INFO - PROCESS | 6042 | Values: 58.0 57.0 57.0 57.0 58.0 58.0 58.0 58.0 59.0 56.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 05:10:28 INFO - PROCESS | 6042 | Values: 67.0 69.0 67.0 68.0 69.0 69.0 68.0 67.0 67.0 68.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:1.13 05:10:28 INFO - PROCESS | 6042 | Values: 86.0 85.0 85.0 85.0 85.0 84.0 86.0 86.0 86.0 88.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:121.00 stddev:3.02 (2.5%) stddev-sans-first:2.96 05:10:28 INFO - PROCESS | 6042 | Values: 123.0 117.0 117.0 122.0 123.0 120.0 120.0 115.0 123.0 117.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.00 stddev:4.45 (3.0%) stddev-sans-first:4.24 05:10:28 INFO - PROCESS | 6042 | Values: 142.0 152.0 151.0 149.0 150.0 142.0 151.0 149.0 150.0 140.0 05:10:28 INFO - PROCESS | 6042 | 05:10:28 INFO - PROCESS | 6042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.00 stddev:2.88 (4.2%) stddev-sans-first:2.83 05:10:28 INFO - PROCESS | 6042 | Values: 72.0 68.0 76.0 68.0 68.0 67.0 68.0 67.0 68.0 67.0 05:10:28 INFO - PROCESS | 6042 | -------- Summary: end -------- 05:10:28 INFO - PROCESS | 6042 | 05:10:29 INFO - TEST-INFO | 6042: exit 0 05:10:29 INFO - TEST-OK | kraken | took 59205ms 05:10:29 INFO - TEST-START | v8_7 05:10:29 INFO - operating with platform_type : linux_ 05:10:29 INFO - Initialising browser for v8_7 test... 05:10:29 INFO - TEST-INFO | started process 6295 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcdZrB5/profile http://localhost:41117/getInfo.html) 05:10:34 INFO - PROCESS | 6295 | __metrics Screen width/height:1600/1200 05:10:34 INFO - PROCESS | 6295 | colorDepth:24 05:10:34 INFO - PROCESS | 6295 | Browser inner width/height: 1024/697 05:10:34 INFO - PROCESS | 6295 | __metrics 05:10:34 INFO - PROCESS | 6295 | 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:10:34 INFO - PROCESS | 6295 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:35 INFO - TEST-INFO | 6295: exit 0 05:10:35 INFO - Browser initialized. 05:10:35 INFO - Running cycle 1/1 for v8_7 test... 05:10:35 INFO - TEST-INFO | started process 6381 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcdZrB5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:46 INFO - PROCESS | 6381 | RSS: Main: 149532672 05:10:46 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | Cycle 1(1): loaded http://localhost:41117/tests/v8_7/run.html (next: http://localhost:41117/tests/v8_7/run.html) 05:11:08 INFO - PROCESS | 6381 | RSS: Main: 177119232 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | __start_tp_report 05:11:08 INFO - PROCESS | 6381 | _x_x_mozilla_page_load 05:11:08 INFO - PROCESS | 6381 | _x_x_mozilla_page_load_details 05:11:08 INFO - PROCESS | 6381 | |i|pagename|runs| 05:11:08 INFO - PROCESS | 6381 | |0;Richards;167.7008217340265 05:11:08 INFO - PROCESS | 6381 | |1;DeltaBlue;190.65776930409913 05:11:08 INFO - PROCESS | 6381 | |2;Encrypt;280.8988764044944 05:11:08 INFO - PROCESS | 6381 | |3;Decrypt;5181.347150259067 05:11:08 INFO - PROCESS | 6381 | |4;RayTrace;1976.2845849802372 05:11:08 INFO - PROCESS | 6381 | |5;Earley;802.5682182985554 05:11:08 INFO - PROCESS | 6381 | |6;Boyer;12500 05:11:08 INFO - PROCESS | 6381 | |7;RegExp;25641.02564102564 05:11:08 INFO - PROCESS | 6381 | |8;Splay;575.0431282346176 05:11:08 INFO - PROCESS | 6381 | |9;NavierStokes;4845.410628019324 05:11:08 INFO - PROCESS | 6381 | __end_tp_report 05:11:08 INFO - PROCESS | 6381 | __startTimestamp1452172268497__endTimestamp 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | ------- Summary: start ------- 05:11:08 INFO - PROCESS | 6381 | Number of tests: 10 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#0] Richards Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 167.7 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#1] DeltaBlue Cycles:1 Average:190.66 Median:190.66 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 190.7 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 280.9 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 5181.3 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 1976.3 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#5] Earley Cycles:1 Average:802.57 Median:802.57 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 802.6 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 12500.0 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 25641.0 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#8] Splay Cycles:1 Average:575.04 Median:575.04 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 575.0 05:11:08 INFO - PROCESS | 6381 | 05:11:08 INFO - PROCESS | 6381 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:11:08 INFO - PROCESS | 6381 | Values: 4845.4 05:11:08 INFO - PROCESS | 6381 | -------- Summary: end -------- 05:11:08 INFO - PROCESS | 6381 | 05:11:09 INFO - TEST-INFO | 6381: exit 0 05:11:09 INFO - TEST-OK | v8_7 | took 39648ms 05:11:09 INFO - SUITE-END | took 1212s 05:11:09 INFO - Completed test suite (00:20:12) 05:11:09 INFO - Working with test: dromaeo_css 05:11:09 INFO - Generating results file: dromaeo_css 05:11:09 INFO - Working with test: kraken 05:11:09 INFO - Generating results file: kraken 05:11:09 INFO - javascript benchmark 05:11:09 INFO - Working with test: v8_7 05:11:09 INFO - Generating results file: v8_7 05:11:09 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:11:09 INFO - process_Request line: dromaeo_css 6892.25 graph.html#tests=[[72,64,35]] 05:11:09 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:09 INFO - process_Request line: kraken 1503.90 graph.html#tests=[[232,64,35]] 05:11:09 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:09 INFO - process_Request line: v8_7 19837.61 graph.html#tests=[[230,64,35]] 05:11:09 INFO - RETURN: dromaeo_css: 6892.25 05:11:09 INFO - RETURN: kraken: 1503.90 05:11:09 INFO - RETURN: v8_7: 19837.61 05:11:09 INFO - javascript benchmark 05:11:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3097.9690203097966, 3185.0, 3239.6760323967605, 3240.5301231321473, 3271.8200498972556, 5036.798528058883, 5157.071727089123, 5218.634695571307, 5244.292020577221, 5286.392064912537, 5165.483451654833, 5176.404713457953, 5243.4232234454175, 5246.554042906358, 5278.47215278472, 4693.694909830867, 4713.976430117845, 4761.381020467335, 4801.943572414063, 4811.903761924759, 4849.296851956464, 4861.562459378655, 4884.926726099111, 4906.53387928148, 4911.803527858881, 4613.838515651953, 4647.907041859144, 4745.952540474603, 4750.144973904696, 4766.285057241407, 4767.284907263904, 4769.95230047702, 4770.928436073462, 4777.737224452654, 4801.8079276828885, 4730.597899178574, 4738.83414080509, 4751.857444276643, 4774.904501909942, 4784.0192760484015, 4901.2648102784515, 5011.198208286657, 5018.874528136789, 5130.1791713326065, 5150.97424512875, 5555.3333599967855, 5557.805476808292, 5563.833085007456, 5571.804986825442, 5572.693501857396, 5429.782808687648, 5576.219329293902, 5587.38538760736, 5595.944040559583, 5602.991461536922, 5225.007248622787, 5229.660072095339, 5249.4750524947585, 5298.019866324742, 5319.9202011969855, 5671.546276297886, 5681.261436013292, 5684.062129748628, 5686.60193786431, 5689.715514224272, 5337.2527846101575, 5487.204355368449, 5490.231367608538, 5491.039068163055, 5496.697681627549, 5472.699001554953, 5475.342958844884, 5505.889882202334, 5637.633553818989, 5680.062789639664, 5537.612367134262, 5550.69471179089, 5558.305211848519, 5564.33228012641, 5573.108302671634, 5509.338879334506, 5574.275344205227, 5575.888482230333, 5577.470140336662, 5623.5220006299105, 4248.468941382327, 4319.07139964909, 4332.285172946492, 4344.500382455994, 4386.342048692722, 3831.5976822433245, 3860.768353898719, 3864.9227015459533, 3887.74729642578, 3904.9609503905167, 5170.40540337866, 5171.2501687255135, 5176.611754118456, 5183.248428977777, 5227.529522343008, 5454.809081682122, 5540.806071787468, 5568.638038527482, 5571.1086226203615, 5573.052581061229, 5213.504717051874, 5228.215767634809, 5237.6071794615555, 5239.240310155006, 5241.292425522582, 4744.240921452551, 4769.093872164278, 4774.785134668949, 4776.665633405698, 4815.3017812417, 5616.157576363578, 5734.340550836624, 5734.770609175586, 5744.626599271034, 5773.191753154478, 5591.524720398812, 5611.466910643482, 5614.410486898817, 5617.32592088952, 5622.32532096151, 5737.311522617146, 5745.626534275259, 5786.826395208151, 5789.189513468202, 5789.9710501447225, 5320.14877619579, 5487.176923461513, 5491.423400542885, 5494.560435165257, 5533.916991245215, 5585.832425027255, 5587.888242235052, 5600.4959553640365, 5603.495685388335, 5603.859903502445, 5385.0, 5409.86475338104, 5448.591355648263, 5450.400455949922, 5451.182322651634, 5281.392639846466, 5309.177077552986, 5336.546393556591, 5342.0, 5355.571554275726, 5237.816676416307, 5238.71187084714, 5239.240310155083, 5255.684658920477, 5284.0, 5289.497497737709, 5303.284056652303, 5311.176767601028, 5347.7593508293, 5376.166694162411, 5330.520253177233, 5380.461953804588, 5402.432744561922, 5406.648567843077, 5444.564434845123], "unit": "score", "name": "dojo.html", "value": 5135.156750958}, {"lowerIsBetter": false, "replicates": [524.1796588339249, 544.1293929712458, 544.6024402186404, 561.9968356483678, 568.6531215958267, 27812.44375112499, 28719.0, 35385.46921796172, 36013.45979810305, 36108.0, 38793.61206387935, 39305.803470982675, 39310.60689393105, 39313.0, 39409.60590394095, 8290.626921788504, 8425.662973481054, 8438.324934005264, 8440.19818117281, 8445.788855278606, 7447.627618619047, 7616.847663046736, 10045.849312260321, 10246.848161886013, 10294.691159265234, 9953.0, 10145.289829711923, 10152.746181345452, 10154.796904061914, 10174.64388746394, 7460.664270107858, 7625.046869141357, 10098.0, 10324.174066074696, 10329.690109296771, 7352.816179595499, 10137.39175649456, 10332.431716255604, 10358.63744768937, 10367.89632103677, 36000.09999750001, 36347.0, 36389.27221455582, 36498.08754781125, 36540.0, 2605.908793192248, 2696.44722831819, 2835.7873159512915, 2852.4009957908866, 2974.4051189762135, 27092.155323691124, 27303.45393092127, 27860.303492412648, 28398.716012839814, 29626.851865740748, 3290.9835450822834, 3317.170707323169, 3436.621971583124, 3452.2405070884365, 3540.681338679531, 261782.0, 263860.0, 264166.0, 264353.0, 265082.0, 52630.0, 58497.41502584919, 59851.0, 59933.40066599366, 59947.0, 48199.5180048202, 65365.0, 66511.0, 66627.33372666308, 66749.66625166843, 15424.614384640474, 15600.141992190538, 15742.527724168292, 15748.527544173694, 15749.685006300038, 10572.735681608021, 10624.734381640366, 10627.468626568641, 10636.89363106359, 10756.946215268874, 19443.708344374845, 19699.40901772949, 19782.0, 19822.0, 19833.702494462595, 7712.190220026929, 7737.0, 7899.802504937307, 7916.247956444128, 8014.519128852171, 922.6632279218171, 967.9806403871883, 994.3685759542598, 996.272720913737, 1079.5411949921252, 28793.7120628791, 28897.56653650197, 29593.704062959096, 31274.84362578218, 32399.838000809847, 942.5711301357866, 1007.2495990487134, 1027.5427434791445, 1054.915606751458, 1057.5188289328337, 13682.452701892013, 16182.352705891632, 16357.83642163587, 16419.0, 17142.485725428258, 443158.0, 453694.0, 456239.0, 456407.0, 458284.0, 54332.18501722477, 55149.44850551443, 55173.72413137909, 55314.72342638261, 55356.44643553594, 1315.7829207193524, 1341.6511706956067, 1352.3035636646937, 1354.939027743754, 1368.0628769293066, 28631.570526442538, 29650.406991860473, 29833.70166298396, 30238.69761302447, 30365.544516831822, 46373.536264636925, 46852.29721554248, 46860.0, 46887.062258755315, 46956.0, 250996.0, 254536.0, 301474.0, 308324.0, 309036.0, 30191.396172076875, 30240.0, 30253.848730757087, 30344.393112138074, 30389.848050759603, 38605.0, 41753.58246417497, 41826.37260441157, 42719.3592096125, 42756.1448771029, 35947.28105437929, 35984.460233097045, 36108.81945590255, 36217.09457263589, 37102.0, 35512.0, 35580.466293005105, 35697.0, 36101.638983609824, 36256.63743362533, 35092.12269693278, 35757.0, 35791.64208357987, 35810.10474738153, 35857.46213806847, 29578.260543486584, 32231.516527251642, 32578.674213257564, 32648.0, 32699.182520437178, 24163.347797657858, 24563.065646114195, 24581.0, 24656.87671561631, 24712.876435617705], "unit": "score", "name": "ext.html", "value": 18413.091960273374}, {"lowerIsBetter": false, "replicates": [356.5311615225979, 358.7721796659121, 362.72432950957267, 365.9853605855766, 366.95229620149377, 13449.26029068401, 13786.0, 16320.75518867218, 16435.4247601334, 16950.491485255432, 14434.5669629911, 15687.45093921713, 16131.0, 16134.83865161351, 16193.0, 5335.7865685372535, 5416.972915135439, 5477.370102438211, 5478.178273259023, 5484.040292948718, 4057.6145266199665, 4169.916601667965, 5403.2705584745945, 5434.103372943459, 5886.352501224862, 5976.581639285252, 5987.790427335044, 5990.880182396371, 6040.0939859021055, 6041.4562689357945, 5879.647221166722, 6042.063480160582, 6052.455279024909, 6056.152138700608, 6058.121572372025, 5308.893822123536, 5322.0686379883755, 5325.733713314357, 5332.226827110087, 5333.466653334674, 19469.805301947083, 20368.490787730276, 20411.387658370124, 20629.4842628934, 20888.582228355346, 1952.4142757172792, 1981.3857704111626, 1985.642584334819, 2087.8642888212216, 2144.356692992096, 11920.761584768255, 11933.522659093625, 12081.395930203542, 12392.0, 12535.18521296122, 1630.1034431062867, 1635.5420482264985, 1659.6846599146245, 1667.5247554446923, 1680.8137634579048, 57310.713446433336, 57380.139297910566, 60284.397156028754, 60477.395226047614, 61122.694386527786, 9333.953330233442, 9628.66299679522, 9788.902110978941, 9798.118169364649, 9857.704268871945, 12943.870561294454, 12952.481900723866, 12963.351832408342, 12981.805272920914, 12991.740165196643, 7362.889556656654, 7405.0, 7411.0736157980255, 7485.176630570633, 7541.095068591694, 7225.277472252733, 7228.530145540523, 7238.312360325761, 7344.669489872968, 7397.778066658009, 4294.677899157513, 4375.124975005012, 4385.210662080793, 4388.188185185751, 4415.315626077963, 1632.9101899395648, 1640.3520609359236, 1647.3739978808217, 1668.457751230855, 1679.7984241890806, 849.4181485682204, 857.4940784936792, 866.618687777376, 923.7275003873873, 961.1589858873485, 14680.366209570962, 15454.459093931659, 15493.14787686688, 16320.265588048565, 17200.82799171992, 909.4134283387178, 917.857732051533, 956.8660387545749, 970.6893793985856, 986.5511192407438, 9497.955224925252, 9864.95067524672, 9865.358751681119, 9886.258530610234, 9890.20878329732, 555224.0, 555817.0, 561851.0, 570436.0, 577746.0, 78107.60946195232, 79753.0, 82161.17838821655, 82167.0, 82870.0, 1157.1090260499368, 1159.8898104680043, 1166.5158959031908, 1169.2516789254714, 1175.189119507537, 15233.619159520656, 15337.539873803804, 15350.692986139991, 15458.922705386402, 15494.612634683772, 35139.47290790589, 35378.292434151685, 35587.82206088953, 36171.45742813807, 36825.81587092047, 45907.770461147484, 46423.0, 47677.28484072811, 48496.5150348492, 50228.748856255486, 9388.906110938804, 9526.90473095288, 9612.567434465605, 9630.133288004114, 9648.662296819577, 13465.528706495226, 17162.141892905554, 17196.054217018183, 17440.302387904343, 17671.116444178, 11083.72290692739, 11612.88387116118, 13790.310484475936, 14167.504137355143, 14579.0, 13859.722805543632, 14199.64500887486, 14379.856201437851, 14640.414383424544, 14869.107853528823, 11039.0, 11410.258333208647, 13188.472461101448, 13977.301134943009, 14378.065425747292, 9219.907800921905, 9321.580528876353, 9328.440293582407, 9345.766355841159, 9346.018668039758, 13385.799213011618, 13429.395677194354, 13549.0, 13792.379342929793, 14043.0], "unit": "score", "name": "jquery.html", "value": 8798.035908366039}, {"lowerIsBetter": false, "replicates": [1272.281161143953, 1481.0595272002279, 1482.7182835261299, 1642.7125253080708, 1818.5817262029732, 6754.831129221766, 7273.963630181848, 7421.962890185541, 7426.777196684095, 7437.516561423504, 7298.744543940963, 7452.06849143857, 7465.51474154181, 7478.326950574461, 7486.812829679247, 1999.3602047344855, 2042.5710600773782, 2106.536561956367, 2140.218820130649, 2213.1700612270397, 2254.5378197469563, 2259.378670865517, 2260.8756518391483, 2263.4907145892207, 2264.762199969004, 2164.8159906407973, 2233.3746550965675, 2234.329701089675, 2235.508188198602, 2235.519363336882, 2213.5462230242842, 2231.776822317763, 2252.054137262354, 2267.251806903718, 2273.147569661377, 2264.275431861805, 2267.478479949621, 2295.414669259345, 2303.9539209215723, 2304.0898844956314, 7319.890201646979, 7418.740344087985, 7418.962905185494, 7421.369183619398, 7431.219721929174, 4458.509563947963, 4543.45478542577, 4574.039451715111, 4583.656225783079, 4588.24293991491, 2881.3516958684127, 2931.2818359501844, 2936.8384738839354, 2941.102963596102, 3091.196288964863, 986.6842610364686, 1001.9949900250452, 1007.2848277722826, 1031.8761748590143, 1031.9019693129142, 10618.52216650245, 10639.308444951053, 10662.0, 10673.466326683634, 10681.145508359312, 4107.260693075275, 4166.291730405838, 4177.728447650893, 4177.874663760092, 4243.342281946303, 8986.281097512183, 9028.458292502472, 9048.41185322965, 9049.638014479478, 9073.31950103745, 4598.126355992351, 4614.74618895964, 4650.116477869194, 4660.13787449323, 4662.323963025342, 4214.7892605370225, 4218.915621687549, 4227.196832601796, 4249.022724773319, 4264.232438161161, 3315.801051936843, 3362.7814192077435, 3536.929261414757, 3551.254236610289, 3619.6561326673923, 1162.8197629367462, 1168.2990205876406, 1185.6028230542865, 1193.254216114928, 1194.6475789642077, 1033.5917312661456, 1034.1158309645145, 1087.3095584304024, 1184.1296646964474, 1339.0158233698223, 7000.844860598047, 7061.89407158893, 7095.9645201773665, 7193.89209161863, 7198.460115491359, 1093.6937657455926, 1097.2812807611028, 1111.216592302425, 1129.8305254211934, 1132.2583707671488, 5696.8006119785605, 5780.277465316835, 5790.0, 5798.130280457881, 5801.622894511843, 9197.356185066981, 9347.392419492711, 9351.438913665203, 9366.718998429922, 9369.203617692436, 9087.318451116193, 9114.40756350835, 9225.354225204306, 9243.861342079874, 9251.121143491358, 7409.592472413961, 7475.514091583921, 7485.326320631169, 7525.924740752523, 7560.206178351194, 6996.0, 7007.754728584475, 7024.051753013277, 7036.648167591702, 7038.824029399306, 8374.330053595575, 8377.748667539983, 8383.874241886499, 8390.580470976305, 8591.31269498426, 8771.16673915977, 8780.0, 8788.38481306328, 8788.824223515621, 8796.428232164888, 6562.671866406756, 6645.933540664531, 6676.365745254193, 6689.732410703712, 6691.197056353269, 6457.289698133295, 6599.340065993362, 6894.896576551256, 7099.964500177673, 7114.9288507116335, 6293.905591416041, 6392.977123660192, 6804.319568043156, 6908.930910690829, 6979.267176946348, 6727.663616819237, 6782.966085169543, 6825.590464572141, 6900.068490753684, 6914.377706006484, 6578.276389597045, 6638.137042184485, 6647.933520664731, 6653.334666533308, 6654.0, 5912.408759124225, 5925.259342582177, 5932.733027013881, 5954.345022047658, 5976.043832986701, 6297.2128483939505, 6329.588576742497, 6329.588576742497, 6330.683465826783, 6338.683065846782], "unit": "score", "name": "mootools.html", "value": 4387.583898180606}, {"lowerIsBetter": false, "replicates": [338.97627166098374, 345.04250704295595, 347.829563513878, 350.73869966874673, 351.3657847585108, 5715.657060576368, 5790.10253410721, 5904.321003084636, 5934.228550288467, 5939.406059394064, 5659.915101273474, 5770.249867517227, 5772.682502462363, 5784.768609255625, 5793.768249270024, 4511.255642818931, 4511.458624965009, 4513.616342610882, 4517.932231016537, 4520.841770538023, 4333.978330108361, 4404.669649776263, 4411.095725376306, 4415.955840441603, 4542.318652202163, 4390.692651514395, 4452.465704115511, 4460.754658493782, 4466.642668586522, 4475.3063275192235, 4447.17727220462, 4449.977750111245, 4453.710508816916, 4456.576625220631, 4470.932936005946, 3895.435161901537, 3900.590438003997, 3904.06302487401, 3914.725969182158, 3916.5691773904846, 5378.650387724785, 5461.617686761928, 5518.227448157261, 5527.834164975057, 5538.363088244822, 5152.252923326134, 5152.6650767699975, 5165.483451654842, 5174.068667639824, 5174.146265866128, 6117.816465506042, 6129.448349648508, 6133.478654314388, 6133.693315334215, 6141.938580614182, 4324.13517296542, 4324.308110702304, 4331.285337919239, 4331.740095594275, 4339.696221264513, 6260.812175634693, 6306.1171435998995, 6433.613983160979, 6440.130582371414, 6445.903311450285, 4427.535108813592, 4433.490148632884, 4438.7114837535455, 4438.733675979452, 4442.666799990014, 4483.237849565582, 4486.1252055849445, 4489.034857505652, 4492.303692927601, 4492.73043617384, 5045.318881950963, 5150.381954165524, 5151.6136289778415, 5163.328767260307, 5165.251038599382, 6164.969175154185, 6165.383461653799, 6175.876482470326, 6178.969105154445, 6190.628562286277, 1571.6306667933027, 1594.2666373468103, 1595.1864549079821, 1596.106180538902, 1598.79215701958, 1076.9569217231224, 1083.3608171179042, 1083.653230966099, 1099.455769394155, 1108.661858133261, 5877.941220587825, 5888.175655408247, 5888.558358123158, 5889.322727886262, 5898.4101589840675, 6168.691565421711, 6319.304876463585, 6319.96840015797, 6362.681865906686, 6372.745090196433, 5657.796937713675, 5799.2460980073165, 5845.152452894306, 5847.912281315784, 5861.941380586225, 3376.122208225879, 3409.454487282023, 3410.6248312685584, 3413.5050417689795, 3414.6926776590226, 6593.175853018372, 6692.096566963398, 6697.162854643169, 6699.464042876656, 6700.296468870796, 6610.504212184105, 6612.471002319803, 6614.768483103068, 6615.735370585219, 6616.768413105518, 6553.770618028346, 6670.433013193933, 6679.499037572202, 6693.096431981718, 6697.966510167418, 6419.935800642121, 6425.1968503937005, 6426.389492998158, 6432.839179020562, 6434.099226108442, 6325.399087086719, 6363.268224154096, 6368.42684158428, 6369.777057802955, 6372.458341040878, 6540.705668245036, 6675.332466753286, 6677.732890684319, 6683.064370987969, 6690.69891854858, 4584.106099310736, 4595.701279416827, 4596.770161491845, 4598.517155698603, 4604.447466304065, 6414.486841052798, 6417.358264173546, 6422.42198202164, 6422.550421470639, 6428.228612566335, 6116.3883611638485, 6264.154339164154, 6281.340459251713, 6285.49716022708, 6292.370762923671, 6236.6258024518675, 6252.781152659635, 6261.96869015652, 6263.342349053284, 6271.78048768291, 6163.7842675506145, 6164.753409863555, 6169.598976066542, 6169.84575385601, 6178.9382106180165, 6172.537059720628, 6319.873602528016, 6321.431071203614, 6322.36776322364, 6329.113924050729, 5927.614705044159, 6071.574989750852, 6164.753409863734, 6173.6913154343, 6174.289956655042], "unit": "score", "name": "prototype.html", "value": 4696.574664278925}, {"lowerIsBetter": false, "replicates": [734.7832389445114, 840.5293035899897, 846.8941382327209, 863.6977058029694, 868.4789126524084, 13592.184468931871, 13791.034627576073, 13818.447262109528, 13847.37686804095, 13848.376823042961, 12828.80756788649, 12947.805782913263, 13025.804612930813, 13058.412371443284, 13186.802197967038, 821.5892053973014, 832.0182185021672, 834.7287131682198, 836.5022811427222, 838.4089217101958, 822.9177082291783, 823.6458322921142, 824.1552408780988, 824.3116997307226, 825.1253671108614, 848.2832006954114, 859.8925134358205, 862.4738909265343, 872.3457406944791, 873.8077622922947, 854.1159899504046, 864.6325311742485, 866.2593482572436, 867.1242045534025, 867.2151702709058, 627.5230824573312, 634.926983396906, 635.6122765113278, 635.7012204263989, 636.1983900285627, 11771.529138834436, 11838.112141589416, 11940.940295298555, 11942.522299108025, 11969.521219151224, 9815.607375704963, 10024.147947424404, 10066.547005384775, 10676.145908327315, 11024.724381890517, 9292.0, 9299.163075323253, 9312.580933857993, 9368.4378937264, 9441.622335106587, 3420.6579342065843, 3471.7049050830456, 3503.1942653189653, 3507.8947631571095, 3581.3195492856535, 41339.0, 41938.37092443616, 45829.77085114553, 45872.0, 46295.30557041613, 9333.859992100124, 9504.619815207452, 9529.428234305826, 9708.708738737849, 9721.027897210222, 17886.910565447088, 17970.91014544919, 18029.098545072695, 18036.819631803777, 18045.0, 7407.407407407502, 7446.34948345721, 7541.472096953161, 7587.393008559302, 7609.961950190324, 4293.5706429356815, 4383.802728877208, 4420.138073075784, 4508.616767574727, 4517.186906356887, 2890.7831912606216, 2920.7663386928994, 2936.9867395748433, 2939.2798764302456, 2942.8822847085876, 506.8023470846373, 509.1827616675257, 524.404800551377, 530.3582664975346, 537.0065379048729, 543.8531596468931, 558.4080874273284, 589.8997170481028, 594.3610618585038, 672.7779832655212, 8224.547649879314, 8376.916230837614, 8472.788180295542, 8740.213380795632, 9290.674826381044, 541.2882060090968, 569.9743511541991, 605.5337390209514, 675.4866301610812, 699.1226011355818, 3673.3020726061964, 3845.538535375773, 3886.055653511688, 3945.6054394560315, 3985.0, 54913.725431372586, 54958.45041549533, 55299.44700552943, 55621.0, 56136.0, 50530.74734626304, 50893.49106508888, 51173.0, 51475.0, 51497.48502514927, 42127.0, 46220.76889615531, 49740.50259497359, 50202.49797502051, 55734.72132639311, 8608.74639058017, 8786.297096232158, 8791.285247140097, 8855.291576673979, 9227.76930576741, 31750.523742143425, 31868.0, 35137.824310878284, 36135.91592252236, 36537.451938220416, 45124.0, 45150.484951504586, 45875.541244587126, 46681.76659116683, 50003.749981249865, 11989.880101199225, 12195.329256890956, 12299.139060265696, 12338.81491777606, 12468.064895133082, 12664.430100645308, 12936.965042796743, 13039.413226405024, 13048.739025219633, 13345.16925701463, 10893.346399215756, 11064.944675276573, 11761.705957351134, 12141.271523708605, 12186.87813121893, 11510.59712910044, 11828.112891533341, 11853.407329633656, 11922.940385298365, 12258.141930065167, 11267.830982535432, 11680.123990700902, 11731.941340293244, 11818.172727909308, 12066.034717222778, 10251.58993640246, 10291.897081029094, 10487.423191724529, 10647.680569582924, 10768.3538987661, 9054.27565794748, 9142.26861851037, 9326.160645541933, 9517.762055948657, 9687.41875487473], "unit": "score", "name": "yui.html", "value": 6252.46919563795}], "name": "dromaeo_css", "value": 6892.246302048783}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 109.0, 109.0, 109.0, 99.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 147.0, 169.0, 124.0, 153.0, 156.0, 132.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 87.0, 102.0, 75.0, 74.0, 75.0, 100.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 144.0, 95.0, 96.0, 96.0, 135.0, 95.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 69.0, 69.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 84.0, 86.0, 86.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 117.0, 122.0, 123.0, 120.0, 120.0, 115.0, 123.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [142.0, 152.0, 151.0, 149.0, 150.0, 142.0, 151.0, 149.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 76.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1503.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "Richards", "value": 210.50582599999998}, {"lowerIsBetter": false, "replicates": [190.65776930409913], "unit": "score", "name": "DeltaBlue", "value": 346.78891000000004}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [802.5682182985554], "unit": "score", "name": "Earley", "value": 830.4128980000002}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [575.0431282346176], "unit": "score", "name": "Splay", "value": 141.71284899999998}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19837.605364192514}]} 05:11:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19837.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6892.25"}}} 05:11:09 INFO - Return code: 0 05:11:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:11:09 INFO - # TBPL SUCCESS # 05:11:09 INFO - Running post-action listener: _resource_record_post_action 05:11:09 INFO - Running post-run listener: _resource_record_post_run 05:11:10 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 558723072; Read time: 144; Write time: 499404 05:11:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 238825472; Read time: 120; Write time: 240556 05:11:10 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319897600; Read time: 24; Write time: 258848 05:11:10 INFO - Running post-run listener: _upload_blobber_files 05:11:10 INFO - Blob upload gear active. 05:11:10 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:11:10 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:11:10 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:11:10 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:11:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:11:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:11:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:12 INFO - (blobuploader) - INFO - Done attempting. 05:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:13 INFO - (blobuploader) - INFO - Done attempting. 05:11:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:13 INFO - Return code: 0 05:11:13 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:11:13 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8b92f03a3a56631fbd90d9cbc96bb6d4c348270b0972903d5095832f4309db548d338980a0ff9b7eac6e8f15f248fa89b83e29128021dcb5ca2d53341821c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19dbd89e36adaf5aa7eb24533e19750d16103d8a164523f3efa4dd487b3abe52889babb73f41e6d6f7514f1f4110255c2a1447d18e576bc0dcbfe4a414d2003"} 05:11:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:11:13 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:11:13 INFO - Contents: 05:11:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8b92f03a3a56631fbd90d9cbc96bb6d4c348270b0972903d5095832f4309db548d338980a0ff9b7eac6e8f15f248fa89b83e29128021dcb5ca2d53341821c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19dbd89e36adaf5aa7eb24533e19750d16103d8a164523f3efa4dd487b3abe52889babb73f41e6d6f7514f1f4110255c2a1447d18e576bc0dcbfe4a414d2003"} 05:11:13 INFO - Copying logs to upload dir... 05:11:13 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.240977 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-07 05:11:12.205249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 05:11:12.209040) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8b92f03a3a56631fbd90d9cbc96bb6d4c348270b0972903d5095832f4309db548d338980a0ff9b7eac6e8f15f248fa89b83e29128021dcb5ca2d53341821c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19dbd89e36adaf5aa7eb24533e19750d16103d8a164523f3efa4dd487b3abe52889babb73f41e6d6f7514f1f4110255c2a1447d18e576bc0dcbfe4a414d2003"} build_url:https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/FNvp3bGdRA2Eb1T_VZ95Tw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8b92f03a3a56631fbd90d9cbc96bb6d4c348270b0972903d5095832f4309db548d338980a0ff9b7eac6e8f15f248fa89b83e29128021dcb5ca2d53341821c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19dbd89e36adaf5aa7eb24533e19750d16103d8a164523f3efa4dd487b3abe52889babb73f41e6d6f7514f1f4110255c2a1447d18e576bc0dcbfe4a414d2003"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 05:11:12.234012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:11:12.234357) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1452169791.750491-999427765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:11:12.317587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 05:11:12.317903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 05:11:12.318222) ========= ========= Total master_lag: 0.18 =========