builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1452183509.08 results: success (0) buildid: 20160107053022 builduid: ee2c27757ca5458890fba04ef963c304 revision: e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.079609) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.080230) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.080536) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.101607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.101921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.120659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.121350) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.173669) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.174177) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.174739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.175203) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 08:18:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 72.4M=0s 2016-01-07 08:18:29 (72.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.281341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.281649) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019149 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.332204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.332562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c --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 e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c --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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 08:18:29,480 truncating revision to first 12 chars 2016-01-07 08:18:29,480 Setting DEBUG logging. 2016-01-07 08:18:29,480 attempt 1/10 2016-01-07 08:18:29,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e2f7ab5a0370?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 08:18:29,721 unpacking tar archive at: fx-team-e2f7ab5a0370/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.880337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.880635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.888731) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.888986) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.889386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-07 08:18:29.889666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:30 INFO - MultiFileLogger online at 20160107 08:18:30 in /builds/slave/test-pgo 08:18:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:18:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:18:30 INFO - {'append_to_log': False, 08:18:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:18:30 INFO - 'blob_upload_branch': 'Fx-Team', 08:18:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:18:30 INFO - 'branch': 'Fx-Team', 08:18:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:30 INFO - 'config_files': ('talos/linux_config.py',), 08:18:30 INFO - 'default_actions': ('clobber', 08:18:30 INFO - 'read-buildbot-config', 08:18:30 INFO - 'download-and-extract', 08:18:30 INFO - 'populate-webroot', 08:18:30 INFO - 'create-virtualenv', 08:18:30 INFO - 'install', 08:18:30 INFO - 'run-tests'), 08:18:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:30 INFO - 'download_minidump_stackwalk': True, 08:18:30 INFO - 'download_symbols': 'ondemand', 08:18:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:30 INFO - 'installer_path': 'installer.exe', 08:18:30 INFO - 'log_level': 'info', 08:18:30 INFO - 'log_name': 'talos', 08:18:30 INFO - 'log_to_console': True, 08:18:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:30 INFO - 'opt_config_files': (), 08:18:30 INFO - 'pip_index': False, 08:18:30 INFO - 'sps_profile': False, 08:18:30 INFO - 'sps_profile_interval': 0, 08:18:30 INFO - 'suite': 'dromaeojs-e10s', 08:18:30 INFO - 'system_bits': '32', 08:18:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:30 INFO - 'title': 'talos-linux64-ix-046', 08:18:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:30 INFO - 'use_talos_json': True, 08:18:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:18:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:30 INFO - 'work_dir': 'build'} 08:18:30 INFO - ##### 08:18:30 INFO - ##### Running clobber step. 08:18:30 INFO - ##### 08:18:30 INFO - Running pre-action listener: _resource_record_pre_action 08:18:30 INFO - Running main action method: clobber 08:18:30 INFO - rmtree: /builds/slave/test-pgo/build 08:18:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:18:30 INFO - Running post-action listener: _resource_record_post_action 08:18:30 INFO - ##### 08:18:30 INFO - ##### Running read-buildbot-config step. 08:18:30 INFO - ##### 08:18:30 INFO - Running pre-action listener: _resource_record_pre_action 08:18:30 INFO - Running main action method: read_buildbot_config 08:18:30 INFO - Using buildbot properties: 08:18:30 INFO - { 08:18:30 INFO - "project": "", 08:18:30 INFO - "product": "firefox", 08:18:30 INFO - "script_repo_revision": "production", 08:18:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:18:30 INFO - "repository": "", 08:18:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:18:30 INFO - "buildid": "20160107053022", 08:18:30 INFO - "pgo_build": "True", 08:18:30 INFO - "basedir": "/builds/slave/test-pgo", 08:18:30 INFO - "buildnumber": 189, 08:18:30 INFO - "slavename": "talos-linux64-ix-046", 08:18:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:18:30 INFO - "platform": "ubuntu64_hw", 08:18:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:18:30 INFO - "branch": "fx-team", 08:18:30 INFO - "repo_path": "integration/fx-team", 08:18:30 INFO - "revision": "e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c", 08:18:30 INFO - "stage_platform": "linux64-pgo", 08:18:30 INFO - "builduid": "ee2c27757ca5458890fba04ef963c304", 08:18:30 INFO - "slavebuilddir": "test" 08:18:30 INFO - } 08:18:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:18:30 INFO - Running post-action listener: _resource_record_post_action 08:18:30 INFO - ##### 08:18:30 INFO - ##### Running download-and-extract step. 08:18:30 INFO - ##### 08:18:30 INFO - Running pre-action listener: _resource_record_pre_action 08:18:30 INFO - Running main action method: download_and_extract 08:18:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:18: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')]} 08:18:30 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json 08:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json 08:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:18:32 INFO - Downloaded 1302 bytes. 08:18:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:18:32 INFO - Using the following test package requirements: 08:18:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'jsshell-linux-x86_64.zip'], 08:18:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:32 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:37 INFO - Downloaded 24056384 bytes. 08:18:37 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 08:18:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:37 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 08:18:38 INFO - Return code: 0 08:18:38 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 08:18:38 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')]} 08:18:38 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:50 INFO - Downloaded 24056384 bytes. 08:18:50 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 08:18:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:50 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 08:18:51 INFO - Return code: 0 08:18:51 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')]} 08:18:51 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:52 INFO - Downloaded 11132285 bytes. 08:18:52 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 08:18:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:52 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 08:18:52 INFO - Return code: 0 08:18:52 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')]} 08:18:52 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:54 INFO - Downloaded 55912600 bytes. 08:18:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:54 INFO - mkdir: /builds/slave/test-pgo/properties 08:18:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:18:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:18:54 INFO - Contents: 08:18:54 INFO - build_url:https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:54 INFO - Running post-action listener: _resource_record_post_action 08:18:54 INFO - Running post-action listener: set_extra_try_arguments 08:18:54 INFO - ##### 08:18:54 INFO - ##### Running populate-webroot step. 08:18:54 INFO - ##### 08:18:54 INFO - Running pre-action listener: _resource_record_pre_action 08:18:54 INFO - Running main action method: populate_webroot 08:18:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:54 INFO - '--tppagecycles', 08:18:54 INFO - '7'], 08:18:54 INFO - 'tests': ['tsvgm']}}, 08:18:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:18:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:18:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:18:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'tests': ['damp', 'tps']}, 08:18:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['damp', 'tps']}, 08:18:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:18:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:54 INFO - 'other': {'tests': ['a11yr', 08:18:54 INFO - 'ts_paint', 08:18:54 INFO - 'tpaint', 08:18:54 INFO - 'sessionrestore', 08:18:54 INFO - 'sessionrestore_no_auto_restore']}, 08:18:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['a11yr', 08:18:54 INFO - 'ts_paint', 08:18:54 INFO - 'tpaint', 08:18:54 INFO - 'sessionrestore', 08:18:54 INFO - 'sessionrestore_no_auto_restore']}, 08:18:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['a11yr', 08:18:54 INFO - 'ts_paint', 08:18:54 INFO - 'tpaint', 08:18:54 INFO - 'sessionrestore', 08:18:54 INFO - 'sessionrestore_no_auto_restore']}, 08:18:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['a11yr', 08:18:54 INFO - 'ts_paint', 08:18:54 INFO - 'tpaint', 08:18:54 INFO - 'sessionrestore', 08:18:54 INFO - 'sessionrestore_no_auto_restore']}, 08:18:54 INFO - 'other_l64': {'tests': ['a11yr', 08:18:54 INFO - 'ts_paint', 08:18:54 INFO - 'tpaint', 08:18:54 INFO - 'sessionrestore', 08:18:54 INFO - 'sessionrestore_no_auto_restore']}, 08:18:54 INFO - 'other_nol64': {'tests': ['a11yr', 08:18:54 INFO - 'ts_paint', 08:18:54 INFO - 'tpaint', 08:18:54 INFO - 'sessionrestore', 08:18:54 INFO - 'sessionrestore_no_auto_restore']}, 08:18:54 INFO - 'svgr': {'tests': ['tsvgx', 08:18:54 INFO - 'tsvgr_opacity', 08:18:54 INFO - 'tart', 08:18:54 INFO - 'tscrollx', 08:18:54 INFO - 'cart']}, 08:18:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['tsvgx', 08:18:54 INFO - 'tsvgr_opacity', 08:18:54 INFO - 'tart', 08:18:54 INFO - 'tscrollx', 08:18:54 INFO - 'cart']}, 08:18:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'tests': ['tp5o']}, 08:18:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'talos_options': ['--e10s'], 08:18:54 INFO - 'tests': ['tp5o']}, 08:18:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'talos_options': ['--xperf_path', 08:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:54 INFO - 'tests': ['tp5n']}, 08:18:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:54 INFO - 'talos_options': ['--e10s', 08:18:54 INFO - '--xperf_path', 08:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:54 INFO - 'tests': ['tp5n']}}, 08:18:54 INFO - 'talos.zip': {'path': '', 08:18:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:54 INFO - Running post-action listener: _resource_record_post_action 08:18:54 INFO - ##### 08:18:54 INFO - ##### Running create-virtualenv step. 08:18:54 INFO - ##### 08:18:54 INFO - Running pre-action listener: _resource_record_pre_action 08:18:54 INFO - Running main action method: create_virtualenv 08:18:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:18:54 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 08:18:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:18:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:54 INFO - Using real prefix '/usr' 08:18:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:18:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:57 INFO - Installing pip.................done. 08:18:57 INFO - Return code: 0 08:18:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:18:57 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')]} 08:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:57 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')]} 08:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:57 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:18:57 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 08:18:57 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 08:18:57 INFO - Using env: {'DISPLAY': ':0', 08:18:57 INFO - 'HOME': '/home/cltbld', 08:18:57 INFO - 'LANG': 'en_US.UTF-8', 08:18:57 INFO - 'LANGUAGE': 'en_US:en', 08:18:57 INFO - 'LOGNAME': 'cltbld', 08:18:57 INFO - 'MAIL': '/var/mail/cltbld', 08:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:57 INFO - 'MOZ_NO_REMOTE': '1', 08:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:57 INFO - 'NO_EM_RESTART': '1', 08:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:18:57 INFO - 'SHELL': '/bin/bash', 08:18:57 INFO - 'SHLVL': '1', 08:18:57 INFO - 'TERM': 'linux', 08:18:57 INFO - 'TMOUT': '86400', 08:18:57 INFO - 'USER': 'cltbld', 08:18:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:57 INFO - '_': '/tools/buildbot/bin/python'} 08:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:57 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 08:18:57 INFO - Cleaning up... 08:18:57 INFO - Return code: 0 08:18:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:18:57 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')]} 08:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:57 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')]} 08:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:57 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:18:57 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 08:18:57 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 08:18:57 INFO - Using env: {'DISPLAY': ':0', 08:18:57 INFO - 'HOME': '/home/cltbld', 08:18:57 INFO - 'LANG': 'en_US.UTF-8', 08:18:57 INFO - 'LANGUAGE': 'en_US:en', 08:18:57 INFO - 'LOGNAME': 'cltbld', 08:18:57 INFO - 'MAIL': '/var/mail/cltbld', 08:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:57 INFO - 'MOZ_NO_REMOTE': '1', 08:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:57 INFO - 'NO_EM_RESTART': '1', 08:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:18:57 INFO - 'SHELL': '/bin/bash', 08:18:57 INFO - 'SHLVL': '1', 08:18:57 INFO - 'TERM': 'linux', 08:18:57 INFO - 'TMOUT': '86400', 08:18:57 INFO - 'USER': 'cltbld', 08:18:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:57 INFO - '_': '/tools/buildbot/bin/python'} 08:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:57 INFO - Downloading/unpacking psutil>=0.7.1 08:18:57 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 08:18:57 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 08:18:57 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 08:18:57 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 08:18:57 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 08:18:57 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 08:18:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:18:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:59 INFO - Installing collected packages: psutil 08:18:59 INFO - Running setup.py install for psutil 08:18:59 INFO - building 'psutil._psutil_linux' extension 08:18:59 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 08:18:59 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 08:18:59 INFO - building 'psutil._psutil_posix' extension 08:18:59 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 08:18:59 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 08:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:00 INFO - Successfully installed psutil 08:19:00 INFO - Cleaning up... 08:19:00 INFO - Return code: 0 08:19:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:00 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 08:19:00 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 08:19:00 INFO - Using env: {'DISPLAY': ':0', 08:19:00 INFO - 'HOME': '/home/cltbld', 08:19:00 INFO - 'LANG': 'en_US.UTF-8', 08:19:00 INFO - 'LANGUAGE': 'en_US:en', 08:19:00 INFO - 'LOGNAME': 'cltbld', 08:19:00 INFO - 'MAIL': '/var/mail/cltbld', 08:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:00 INFO - 'MOZ_NO_REMOTE': '1', 08:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:00 INFO - 'NO_EM_RESTART': '1', 08:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:00 INFO - 'SHELL': '/bin/bash', 08:19:00 INFO - 'SHLVL': '1', 08:19:00 INFO - 'TERM': 'linux', 08:19:00 INFO - 'TMOUT': '86400', 08:19:00 INFO - 'USER': 'cltbld', 08:19:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:00 INFO - '_': '/tools/buildbot/bin/python'} 08:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:19:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:19:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:19:02 INFO - Installing collected packages: mozsystemmonitor 08:19:02 INFO - Running setup.py install for mozsystemmonitor 08:19:02 INFO - Successfully installed mozsystemmonitor 08:19:02 INFO - Cleaning up... 08:19:02 INFO - Return code: 0 08:19:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:19: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')]} 08:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:02 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:02 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 08:19:02 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 08:19:02 INFO - Using env: {'DISPLAY': ':0', 08:19:02 INFO - 'HOME': '/home/cltbld', 08:19:02 INFO - 'LANG': 'en_US.UTF-8', 08:19:02 INFO - 'LANGUAGE': 'en_US:en', 08:19:02 INFO - 'LOGNAME': 'cltbld', 08:19:02 INFO - 'MAIL': '/var/mail/cltbld', 08:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:02 INFO - 'MOZ_NO_REMOTE': '1', 08:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:02 INFO - 'NO_EM_RESTART': '1', 08:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:02 INFO - 'SHELL': '/bin/bash', 08:19:02 INFO - 'SHLVL': '1', 08:19:02 INFO - 'TERM': 'linux', 08:19:02 INFO - 'TMOUT': '86400', 08:19:02 INFO - 'USER': 'cltbld', 08:19:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:02 INFO - '_': '/tools/buildbot/bin/python'} 08:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:19:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:19:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:19:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 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 08:19:04 INFO - Downloading docopt-0.6.1.tar.gz 08:19:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:19:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:04 INFO - Running setup.py install for blobuploader 08:19:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:19:04 INFO - Running setup.py install for requests 08:19:05 INFO - Running setup.py install for docopt 08:19:05 INFO - Successfully installed blobuploader requests docopt 08:19:05 INFO - Cleaning up... 08:19:05 INFO - Return code: 0 08:19:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:05 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:05 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 08:19:05 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 08:19:05 INFO - Using env: {'DISPLAY': ':0', 08:19:05 INFO - 'HOME': '/home/cltbld', 08:19:05 INFO - 'LANG': 'en_US.UTF-8', 08:19:05 INFO - 'LANGUAGE': 'en_US:en', 08:19:05 INFO - 'LOGNAME': 'cltbld', 08:19:05 INFO - 'MAIL': '/var/mail/cltbld', 08:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:05 INFO - 'MOZ_NO_REMOTE': '1', 08:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:05 INFO - 'NO_EM_RESTART': '1', 08:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:05 INFO - 'SHELL': '/bin/bash', 08:19:05 INFO - 'SHLVL': '1', 08:19:05 INFO - 'TERM': 'linux', 08:19:05 INFO - 'TMOUT': '86400', 08:19:05 INFO - 'USER': 'cltbld', 08:19:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:05 INFO - '_': '/tools/buildbot/bin/python'} 08:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:05 INFO - Running setup.py (path:/tmp/pip-yon35w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:05 INFO - Running setup.py (path:/tmp/pip-m50Hix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:05 INFO - Running setup.py (path:/tmp/pip-jSzA_Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:05 INFO - Running setup.py (path:/tmp/pip-cGlQqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:05 INFO - Running setup.py (path:/tmp/pip-uw6UQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:06 INFO - Running setup.py (path:/tmp/pip-kuoxVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:06 INFO - Running setup.py (path:/tmp/pip-29hgTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:06 INFO - Running setup.py (path:/tmp/pip-WrQB6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:06 INFO - Running setup.py (path:/tmp/pip-DgKWWg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:06 INFO - Running setup.py (path:/tmp/pip-uwsCUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:06 INFO - Running setup.py (path:/tmp/pip-C4m3hN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:06 INFO - Running setup.py (path:/tmp/pip-Puhmn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:06 INFO - Running setup.py (path:/tmp/pip-AtNdVP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:06 INFO - Running setup.py (path:/tmp/pip-njrWDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:06 INFO - Running setup.py (path:/tmp/pip-1_tmnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:06 INFO - Running setup.py (path:/tmp/pip-pbNYx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:06 INFO - Running setup.py (path:/tmp/pip-r84XNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:06 INFO - Running setup.py install for manifestparser 08:19:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Running setup.py install for mozcrash 08:19:07 INFO - Running setup.py install for mozdebug 08:19:07 INFO - Running setup.py install for mozdevice 08:19:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Running setup.py install for mozfile 08:19:07 INFO - Running setup.py install for mozhttpd 08:19:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Running setup.py install for mozinfo 08:19:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Running setup.py install for mozInstall 08:19:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Running setup.py install for mozleak 08:19:07 INFO - Running setup.py install for mozlog 08:19:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:19:07 INFO - Running setup.py install for moznetwork 08:19:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:19:08 INFO - Running setup.py install for mozprocess 08:19:08 INFO - Running setup.py install for mozprofile 08:19:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:19:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:19:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:19:08 INFO - Running setup.py install for mozrunner 08:19:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:19:08 INFO - Running setup.py install for mozscreenshot 08:19:08 INFO - Running setup.py install for moztest 08:19:08 INFO - Running setup.py install for mozversion 08:19:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:19:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:08 INFO - Cleaning up... 08:19:08 INFO - Return code: 0 08:19:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 08:19:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 08:19:08 INFO - Using env: {'DISPLAY': ':0', 08:19:08 INFO - 'HOME': '/home/cltbld', 08:19:08 INFO - 'LANG': 'en_US.UTF-8', 08:19:08 INFO - 'LANGUAGE': 'en_US:en', 08:19:08 INFO - 'LOGNAME': 'cltbld', 08:19:08 INFO - 'MAIL': '/var/mail/cltbld', 08:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:08 INFO - 'MOZ_NO_REMOTE': '1', 08:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:08 INFO - 'NO_EM_RESTART': '1', 08:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:08 INFO - 'SHELL': '/bin/bash', 08:19:08 INFO - 'SHLVL': '1', 08:19:08 INFO - 'TERM': 'linux', 08:19:08 INFO - 'TMOUT': '86400', 08:19:08 INFO - 'USER': 'cltbld', 08:19:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:08 INFO - '_': '/tools/buildbot/bin/python'} 08:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:08 INFO - Running setup.py (path:/tmp/pip-djPiYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:08 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)) 08:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:08 INFO - Running setup.py (path:/tmp/pip-d8hoJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:09 INFO - Running setup.py (path:/tmp/pip-yPIfuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:09 INFO - Running setup.py (path:/tmp/pip-KlxJya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:09 INFO - Running setup.py (path:/tmp/pip-FPMpCq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:09 INFO - Running setup.py (path:/tmp/pip-C5RPx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:09 INFO - Running setup.py (path:/tmp/pip-t2RXBa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:09 INFO - Running setup.py (path:/tmp/pip-YtgdQL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:09 INFO - Running setup.py (path:/tmp/pip-vB2VKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:09 INFO - Running setup.py (path:/tmp/pip-p3W3SA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:09 INFO - Running setup.py (path:/tmp/pip-63Gtni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:09 INFO - Running setup.py (path:/tmp/pip-Ts9Wwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:09 INFO - Running setup.py (path:/tmp/pip-PaSTvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:09 INFO - Running setup.py (path:/tmp/pip-VkRGOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:09 INFO - Running setup.py (path:/tmp/pip-NwxLsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:09 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)) 08:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:09 INFO - Running setup.py (path:/tmp/pip-fnRxkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:10 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)) 08:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:10 INFO - Running setup.py (path:/tmp/pip-29qmF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - Downloading blessings-1.5.1.tar.gz 08:19:11 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 08:19:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:11 INFO - Installing collected packages: blessings 08:19:11 INFO - Running setup.py install for blessings 08:19:12 INFO - Successfully installed blessings 08:19:12 INFO - Cleaning up... 08:19:12 INFO - Return code: 0 08:19:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:19:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:19:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:19:12 INFO - Reading from file tmpfile_stdout 08:19:12 INFO - Current package versions: 08:19:12 INFO - argparse == 1.2.1 08:19:12 INFO - blessings == 1.5.1 08:19:12 INFO - blobuploader == 1.2.4 08:19:12 INFO - docopt == 0.6.1 08:19:12 INFO - manifestparser == 1.1 08:19:12 INFO - mozInstall == 1.12 08:19:12 INFO - mozcrash == 0.16 08:19:12 INFO - mozdebug == 0.1 08:19:12 INFO - mozdevice == 0.47 08:19:12 INFO - mozfile == 1.2 08:19:12 INFO - mozhttpd == 0.7 08:19:12 INFO - mozinfo == 0.9 08:19:12 INFO - mozleak == 0.1 08:19:12 INFO - mozlog == 3.1 08:19:12 INFO - moznetwork == 0.27 08:19:12 INFO - mozprocess == 0.22 08:19:12 INFO - mozprofile == 0.28 08:19:12 INFO - mozrunner == 6.11 08:19:12 INFO - mozscreenshot == 0.1 08:19:12 INFO - mozsystemmonitor == 0.0 08:19:12 INFO - moztest == 0.7 08:19:12 INFO - mozversion == 1.4 08:19:12 INFO - psutil == 3.1.1 08:19:12 INFO - requests == 1.2.3 08:19:12 INFO - wsgiref == 0.1.2 08:19:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:12 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')]} 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 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')]} 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:12 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 08:19:12 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 08:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 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)) 08:19:12 INFO - Cleaning up... 08:19:12 INFO - Return code: 0 08:19:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:19:12 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')]} 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 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')]} 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:12 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 08:19:12 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 08:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:12 INFO - Downloading/unpacking jsonschema 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:14 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 08:19:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:19:14 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 08:19:14 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 08:19:14 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 08:19:14 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 08:19:14 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 08:19:14 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 08:19:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:14 INFO - warning: no files found matching '*.txt' 08:19:14 INFO - no previously-included directories found matching 'build' 08:19:14 INFO - no previously-included directories found matching 'dist' 08:19:14 INFO - no previously-included directories found matching '.git*' 08:19:14 INFO - Installing collected packages: jsonschema, functools32 08:19:14 INFO - Running setup.py install for functools32 08:19:14 INFO - warning: no files found matching '*.txt' 08:19:14 INFO - no previously-included directories found matching 'build' 08:19:14 INFO - no previously-included directories found matching 'dist' 08:19:14 INFO - no previously-included directories found matching '.git*' 08:19:14 INFO - Successfully installed jsonschema functools32 08:19:14 INFO - Cleaning up... 08:19:14 INFO - Return code: 0 08:19:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:19: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')]} 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:14 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 0x7fa71f3c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, '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': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', '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 08:19:14 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 08:19:14 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 08:19:14 INFO - Using env: {'DISPLAY': ':0', 08:19:14 INFO - 'HOME': '/home/cltbld', 08:19:14 INFO - 'LANG': 'en_US.UTF-8', 08:19:14 INFO - 'LANGUAGE': 'en_US:en', 08:19:14 INFO - 'LOGNAME': 'cltbld', 08:19:14 INFO - 'MAIL': '/var/mail/cltbld', 08:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:14 INFO - 'MOZ_NO_REMOTE': '1', 08:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:14 INFO - 'NO_EM_RESTART': '1', 08:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:14 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:14 INFO - 'SHELL': '/bin/bash', 08:19:14 INFO - 'SHLVL': '1', 08:19:14 INFO - 'TERM': 'linux', 08:19:14 INFO - 'TMOUT': '86400', 08:19:14 INFO - 'USER': 'cltbld', 08:19:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:14 INFO - '_': '/tools/buildbot/bin/python'} 08:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:15 INFO - Downloading/unpacking flake8 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 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 08:19:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:16 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 08:19:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:16 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 08:19:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:17 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 08:19:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:17 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 08:19:17 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 08:19:17 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 08:19:17 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 08:19:17 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 08:19:17 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 08:19:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:19:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:17 INFO - no previously-included directories found matching 'docs/_build' 08:19:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:17 INFO - Running setup.py install for pep8 08:19:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:17 INFO - no previously-included directories found matching 'docs/_build' 08:19:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:19:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:17 INFO - Cleaning up... 08:19:17 INFO - Return code: 0 08:19:17 INFO - Running post-action listener: _resource_record_post_action 08:19:17 INFO - Running post-action listener: _start_resource_monitoring 08:19:17 INFO - Starting resource monitoring. 08:19:17 INFO - ##### 08:19:17 INFO - ##### Running install step. 08:19:17 INFO - ##### 08:19:17 INFO - Running pre-action listener: _resource_record_pre_action 08:19:17 INFO - Running main action method: install 08:19:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:19:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:19:17 INFO - Reading from file tmpfile_stdout 08:19:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:19:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:19:17 INFO - Reading from file tmpfile_stdout 08:19:17 INFO - Output received: 08:19:17 INFO - Usage: mozinstall [options] installer 08:19:17 INFO - Options: 08:19:17 INFO - -h, --help show this help message and exit 08:19:17 INFO - -d DEST, --destination=DEST 08:19:17 INFO - Directory to install application into. [default: 08:19:17 INFO - "/builds/slave/test-pgo"] 08:19:17 INFO - --app=APP Application being installed. [default: firefox] 08:19:17 INFO - mkdir: /builds/slave/test-pgo/build/application 08:19:17 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'] 08:19:17 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 08:19:34 INFO - Reading from file tmpfile_stdout 08:19:34 INFO - Output received: 08:19:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:19:34 INFO - Running post-action listener: _resource_record_post_action 08:19:34 INFO - ##### 08:19:34 INFO - ##### Running run-tests step. 08:19:34 INFO - ##### 08:19:34 INFO - Running pre-action listener: _resource_record_pre_action 08:19:34 INFO - Running main action method: run_tests 08:19:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:19:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:19:34 INFO - Python 2.7.3 08:19:34 INFO - Return code: 0 08:19:34 INFO - grabbing minidump binary from tooltool 08:19: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')]} 08:19:34 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 0xf81840>, '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 0xeee6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeeeb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:19:34 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 08:19:34 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 08:19:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:34 INFO - Return code: 0 08:19:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:19:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:19:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:19:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:19:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:19:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:19:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:19:35 INFO - Return code: 0 08:19:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 08:19:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:19:35 INFO - Using env: {'DISPLAY': ':0', 08:19:35 INFO - 'HOME': '/home/cltbld', 08:19:35 INFO - 'LANG': 'en_US.UTF-8', 08:19:35 INFO - 'LANGUAGE': 'en_US:en', 08:19:35 INFO - 'LOGNAME': 'cltbld', 08:19:35 INFO - 'MAIL': '/var/mail/cltbld', 08:19:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:19:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:35 INFO - 'MOZ_NO_REMOTE': '1', 08:19:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:35 INFO - 'NO_EM_RESTART': '1', 08:19:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:35 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:19:35 INFO - 'SHELL': '/bin/bash', 08:19:35 INFO - 'SHLVL': '1', 08:19:35 INFO - 'TERM': 'linux', 08:19:35 INFO - 'TMOUT': '86400', 08:19:35 INFO - 'USER': 'cltbld', 08:19:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418', 08:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:35 INFO - '_': '/tools/buildbot/bin/python'} 08:19:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:19:35 INFO - mozversion application_buildid: 20160107053022 08:19:35 INFO - mozversion application_changeset: e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c 08:19:35 INFO - mozversion application_display_name: Nightly 08:19:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:35 INFO - mozversion application_name: Firefox 08:19:35 INFO - mozversion application_remotingname: firefox 08:19:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:19:35 INFO - mozversion application_vendor: Mozilla 08:19:35 INFO - mozversion application_version: 46.0a1 08:19:35 INFO - mozversion platform_buildid: 20160107053022 08:19:35 INFO - mozversion platform_changeset: e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c 08:19:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:19:35 INFO - mozversion platform_version: 46.0a1 08:19:35 INFO - using testdate: 1452183575 08:19:35 INFO - actual date: 1452183575 08:19:35 INFO - starting webserver on 'localhost:47973' 08:19:35 INFO - SUITE-START | Running 3 tests 08:19:35 INFO - TEST-START | dromaeo_css 08:19:35 INFO - operating with platform_type : linux_ 08:19:35 INFO - Initialising browser for dromaeo_css test... 08:19:35 INFO - TEST-INFO | started process 24115 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHis_r0/profile http://localhost:47973/getInfo.html) 08:19:39 INFO - PROCESS | 24115 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 08:19:40 INFO - PROCESS | 24115 | __metrics Screen width/height:1600/1200 08:19:40 INFO - PROCESS | 24115 | colorDepth:24 08:19:40 INFO - PROCESS | 24115 | Browser inner width/height: 1024/697 08:19:40 INFO - PROCESS | 24115 | __metrics 08:19:40 INFO - PROCESS | 24115 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:19:41 INFO - TEST-INFO | 24115: exit 0 08:19:41 INFO - Browser initialized. 08:19:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:41 INFO - TEST-INFO | started process 24248 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHis_r0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:53 INFO - PROCESS | 24248 | RSS: Main: 150740992 08:19:53 INFO - PROCESS | 24248 | 08:20:42 INFO - PROCESS | 24248 | 1452183642599 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] 08:22:51 INFO - PROCESS | 24248 | Cycle 1(1): loaded http://localhost:47973/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47973/tests/dromaeo/cssquery-ext.html) 08:22:52 INFO - PROCESS | 24248 | RSS: Main: 157351936 08:22:52 INFO - PROCESS | 24248 | 08:25:54 INFO - PROCESS | 24248 | Cycle 1(1): loaded http://localhost:47973/tests/dromaeo/cssquery-ext.html (next: http://localhost:47973/tests/dromaeo/cssquery-jquery.html) 08:25:55 INFO - PROCESS | 24248 | RSS: Main: 153407488 08:25:55 INFO - PROCESS | 24248 | 08:28:57 INFO - PROCESS | 24248 | Cycle 1(1): loaded http://localhost:47973/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47973/tests/dromaeo/cssquery-mootools.html) 08:28:57 INFO - PROCESS | 24248 | RSS: Main: 152662016 08:28:57 INFO - PROCESS | 24248 | 08:31:59 INFO - PROCESS | 24248 | Cycle 1(1): loaded http://localhost:47973/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47973/tests/dromaeo/cssquery-prototype.html) 08:31:59 INFO - PROCESS | 24248 | RSS: Main: 152657920 08:31:59 INFO - PROCESS | 24248 | 08:35:02 INFO - PROCESS | 24248 | Cycle 1(1): loaded http://localhost:47973/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47973/tests/dromaeo/cssquery-yui.html) 08:35:02 INFO - PROCESS | 24248 | RSS: Main: 153063424 08:35:02 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | Cycle 1(1): loaded http://localhost:47973/tests/dromaeo/cssquery-yui.html (next: http://localhost:47973/tests/dromaeo/cssquery-dojo.html) 08:38:05 INFO - PROCESS | 24248 | RSS: Main: 155779072 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | __start_tp_report 08:38:05 INFO - PROCESS | 24248 | _x_x_mozilla_page_load 08:38:05 INFO - PROCESS | 24248 | _x_x_mozilla_page_load_details 08:38:05 INFO - PROCESS | 24248 | |i|pagename|runs| 08:38:05 INFO - PROCESS | 24248 | |0;dojo.html;3067.907962761117;3112.0197137901546;3119.8752049918003;3141.308912039352;3170.4610216263236;5181.326427564421;5239.711815850127;5264.894702105965;5271.472852714732;5307.150855863063;5224.1902505111675;5224.686518808865;5234.345706786652;5268.446813084628;5279.472052794728;4839.709617422948;4900.6569540132205;4918.114739346916;4939.851804445872;4953.851384458472;4759.309900064489;4950.084234416627;4953.653244272902;4977.7262250576205;4998.5501304882555;4851.63612729045;4933.728644924546;4934.309196712463;4938.789996450892;4987.251912213179;4778.4265888093305;4794.808207671689;4797.328374027639;4826.155422801031;4826.32431459596;4693.296005599187;4711.670183087185;4797.160496913027;4805.951940480585;4859.465458799529;5199.298094757197;5211.348581427322;5230.424653288135;5260.237265596467;5278.868028299324;5748.8850222995725;5752.0796672532615;5770.307563092456;5770.913436298459;5826.329972053226;5599.076152434844;5696.629719068289;5702.173184888209;5766.163906233614;5849.61977471463;5372.140457526777;5375;5394.487523685244;5403.648762830403;5411.377691565481;5847.152162936435;5895.41045895407;5903.203067585907;5912.615679980788;5921.970390148022;5507.642003269774;5564.054110801093;5605.80379686709;5705.62913410627;5747.712614369265;5734.082546792577;5742.655440673573;5743.827685169452;5745.253117094751;5753.913691294634;5694.174344719992;5701.458361455655;5706.543476521868;5709.600327977085;5725.570582206351;5495.945040549544;5558.888822223533;5622.044252477089;5673.461021202979;5692.544596432275;4394.694441534596;4418.270985287391;4422.115576884572;4437.423134992495;4469.955300447019;3891.0077930127636;3933.8033098344968;3940;3947.388154836005;3998.080441498472;5323.840284791462;5327.547158491494;5373.892522149613;5395.406505284415;5449.863753406117;5695.288088988877;5740.598158128974;5743.569232307594;5763.711814409263;5763.88472230553;5273.789048438096;5367.865803354947;5373.623846330719;5379.488948549882;5431.103867861838;4889.682170658967;4903.754812259444;4922.926156107661;4935.975320123376;4999.77501012448;5762.942370576325;5766.509846662997;5774.422557744276;5793.971030144907;5803.88392232153;5521;5583.2462617547735;5614.915776263441;5697.800576979786;5740.311162660508;5998.25021872266;6006.459418652167;6011.308699499614;6018.668973206516;6028.547858910687;5652.208690783212;5710.743016564182;5739.9139012915675;5742.741576629145;5744.741486633196;5598.10430331145;5676.971615141898;5712.885742285214;5796.21751063601;5812.418758124323;5648.406917273627;5650.434956504317;5653.717314134359;5654.15187721845;5654.519365853948;5649.067903795828;5651.378348381757;5652.802151924663;5652.802151924663;5655.377908430151;5411.269478620336;5433.701146436984;5498.505134537911;5540.030494663337;5542.722863856871;5537.972310138423;5564.666120032811;5572.665640061447;5589.217509548747;5608.887822243614;5352.330958630171;5498.285222920995;5555.527780138572;5563.1655251710945;5590.888182236414 08:38:05 INFO - PROCESS | 24248 | |1;ext.html;527.9076161671707;554.9972250138749;568.4258898512501;580.7589850212162;588.5203559099335;34832.303353932904;35345;35383;35456.82271588645;35483.64516354835;38195;38638.420423693664;38800;38911.41632875509;38995;8427.789305267355;8567.485950842969;8619;8620.827583448327;8645.610947507377;8424.578771061422;8528.360372972022;8553;8655.437396569203;8706.956465217665;8682.088380720028;8762.86082809234;8770.079141690127;8794.208521233088;8811.691590794324;8692.217700406962;8694;8721;8739.737807865775;8756.518391488466;8461.450005749606;8581.828363432758;8606.440581362254;8624.65501379944;8625.827483450359;38730.61269387298;39056;39200.607993919984;39214.68638449768;39235.60764392348;3015.321552650636;3172.524121381788;3232.2565809863627;3302.653221411765;3391.8982430526876;26012.479750405077;26384;26395.604065939027;26694.73305266942;26741;3402.3535528249554;3424.028127372236;3436.60479044908;3508.2457271686453;3597.3524765542193;255175;255268.72365638238;255832;255871;257929.99999999814;40879.591204088174;41715.37426938598;61738.69130654318;61950.69024654848;62066.68966655138;42949.14101717948;43066.339361154656;43284.78357608192;43315.13369732588;43492.13015739668;13617.591472255848;13817.240051797047;13924.094933829268;13942.721145577032;13988.160710357412;10788.946055269831;10821.350718956888;10823.56705731762;10886.782264354826;10900.727481812859;14163.716725665636;14253.64365890861;14278.571642850731;14351;14436.206008669415;5710.942890571041;5795.478406943311;5819.854503637443;5834.3290521589715;5848.444397782204;891.9286457083417;897.4032268541347;947.9052094790466;970.9368891022061;977.3061126600194;25381;26175;26244.73755262423;26488.60267095995;30755.69244307573;1005.8692369992001;1096.9286996345213;1128.3906690387264;1153.5155234801402;1155.9190856639955;15031.924840375728;15295.093932152855;15343.156126413154;15434.15112168819;15595;368662;374929;375101;375456;375851;54351.184732228256;54444.45555544473;54775.178372324444;54973.45026549763;54993;1325.3770727757937;1326.9004824637998;1335.4190926946615;1339.8928085753116;1439.0286556574479;27804.304892377044;28911;29235.269118271364;29408;29419;46263.07473850571;46526.76736616295;46736.76631616956;47053.294200587705;47120;302001;302838;303517;303579;305153;32691.34617307688;42029.78985105055;42266;42514.78742606267;42645.14709705726;38510.80744596259;38666.22667546577;39136.804315979374;39455.80272098621;40050.39924401078;33681;33996.66003340034;34132.488012679336;34215;38922.416163757;33802.66197337995;34293.82853085719;34499.4825077619;34608.65391346054;35269.64730352664;33474.66525334716;33606.49590256099;33614.83192584021;33631.3273734519;33838.83080584581;30803;31466.528002080446;31654.841725792146;31691;31959.520607191374;23856.88071559631;24017.91471515942;25257.531874235337;25712;25935 08:38:05 INFO - PROCESS | 24248 | |2;jquery.html;353.15243415802087;354.69673429218017;357.7799653213273;359.8254846399496;361.9764715293506;16319.428819991303;16850.578735531617;17235.310587576514;17903.104844757774;17912.552186195353;9915.10764031237;10090.486695915904;15438.228088595553;15550.533483995498;15612.141332226724;4749.335093086971;4749.525047495249;4847.345608342882;4867.440244371907;4871.926921096187;4835.226363781796;4853.587445067156;4853.708777473363;4856.271559266103;4878.195097808857;4835.709857408549;4851.884066664669;5006.148954677696;5181.1192097343355;5192.740362981855;5103.438621751604;5135.768890399941;5141.897162056775;5143.434222235551;5167.7932882684645;5213.4525874782985;5255.789768409259;5260.421353651095;5271.815486457956;5274.55166310864;19831;19949;19976.3008294709;20430.69353959677;20454;2011.517235863397;2027.6248893954667;2131.4884427737234;2170.1861801824316;2328.5342931413616;9046.77383065422;9168.358214924958;9269.814603707888;9376.8593471098;9571.856422153603;1764.126757255167;1808.1682426084017;1829.4145873320542;1846.3630047633544;1869.7382366468705;56572;58743.706281468316;60666.39333606652;60946.695266523384;61799.69100154471;10316.638917637847;10430.16558675304;10505.52725127371;10512.21158413122;10538.209634277306;13319.067665263532;13424.060315777997;13441.462341506425;13500.729985400238;13509.459621615026;7400.888986665204;7406.962965185139;7446.515976461513;7519.060117485315;7524.586147761816;7021.648917554102;7058.858822823515;7099.858002840017;7136.3220494052985;7146.571205727673;4309.612134907873;4369.868903932887;4459.10817836434;4515.300128480091;4539.432570928634;1836.8714190006572;1859.395696398676;1859.9628007439776;1865.6735071362457;1880.3794747733216;400.8516848765917;406.8901396622895;417.230210262066;437.36363590975054;454.6590057456907;10264.281500294908;10663.946680266548;10812.56749730002;10823.945880270549;10872.075873550679;428.14584903117856;435.1080285414887;438.27465544523864;455.76072561905266;467.60487388157634;5911.556633252523;5980.282366116007;6067.2112625359305;6076.848078797977;6095.329513753483;549420;553323.7001444981;563463;564490;570279;82276.58861705773;83585;84042;84142;85250.57374713087;451.36357735592657;1084.7830433913248;1119.535392811974;1122.9887701123048;1129.1136457880525;14777;14913.3289001993;15003.174825384709;15112.773308400603;15485.458008969632;32517.18707032343;32529.512057319633;32997.50503742494;33594.160145996546;34014;42172.57827421809;43165.76256780817;43245;43780.34329484997;44127.33808992804;8947.552622368725;9365.906340936503;9433.669821556212;9451.05489451077;9457.810843782949;10887.782244355227;10999.61501347449;11959.342236177094;16137.112458814878;16332.346706132097;13233.073684842353;13375;13745.175289482662;14150.646233843825;14751.92624036873;13746.518871839438;14026.929865350608;14048.578542643738;14355.856441435451;14359.497417590333;13939.651508711957;14085.788713169515;14447;14514.63713407131;14696.265186740835;8921.821563568823;9172.633094676405;9193.218576421079;9226.815463690822;9288.164065234161;9630.229581633592;10124.69625911224;13461.326933653474;13911.165330080228;13917.304134793423 08:38:05 INFO - PROCESS | 24248 | |3;mootools.html;1441.2433472426978;1449.4202319072374;1591.9283632236547;1705.9317627294909;1753.6584512847683;7314.232005639411;7389.556626602401;7527.548347099178;7552.5846078465665;7559.281868222523;7456.291652293037;7490.288422599844;7492.250774922505;7518.097828260617;7567.394608431326;2160.1899287767087;2189.638709612912;2190.036383991047;2193.56128774245;2196.374033400481;2263.287064574662;2290.393045842853;2302.4934514406887;2307.273208939179;2309.7805708457668;2176.912923483059;2205.404540773998;2228.097620463715;2242.831787615927;2245.090738251011;2237.463008877874;2258.8870556472193;2284.8514846535004;2285.177336158973;2289.473421113153;2275.8634481931135;2286.6112760830697;2291.175176936302;2303.2974942642486;2306.8731219782903;7388.482806203568;7447.069116360455;7481.177070522238;7496.212897645723;7507.8498430031095;4482.058767658796;4539.909201815978;4588.2888152336445;4588.839390621346;4593.448786145684;2808.705085965985;2896.898608548691;2899.4635992341273;2907.2877145099587;2920.0217926994483;842.3135144856922;864.9740507784777;878.3675753457501;933.286036182321;939.6805086270632;9954.950225248827;10011.949940250324;10025.44860032698;10027.548760305805;10041.899581004169;3953.446517487554;4023.637872591481;4055.3105971984833;4057.046594050396;4059.350503919418;8306.626201820933;8315.376346774015;8329.875051874227;8332.250097491255;8336.083030866599;4473.4408198975125;4486.528914463999;4494.056248187917;4526.275795872644;4531.77341132942;3976.2842688315804;4114.382842573638;4118.732282401695;4128.587141285848;4132.793360331972;3435.0725304167736;3462.4806279058344;3477.113336099329;3499.3176330615283;3504.7546671733244;1075.2365820267541;1077.2136340471343;1082.1721383141903;1082.4912291223113;1084.9909584086718;1195.1036722458157;1195.677167164878;1200.9939950300193;1302.5571305756089;1317.637649646355;6921.134858142732;6963;7003.019577259086;7097.112860892388;7137.464690148259;446.92849144136784;450.2818005281571;451.907358991406;453.360761326528;456.6050366433078;5440.6735595864375;5497.972510137423;5524.751386187631;5551.1673249012165;5581.358143813513;8700.521471319138;8749.343799215085;8871.556422178865;8877.156670116328;8972.37193396469;8648.264897483785;8683.435576687496;8757.91242087571;8764.5179515126;8820.603072861737;6866.416354609814;6872.209695884937;6896.931030689629;6994.650267486605;7039.788806335818;6837.145356830396;6855;6855.725770969305;6860.897086543806;6871.622060786704;7560.054993125859;7779.105402878515;7779.883301750591;7856.882146767917;7938.166492518433;7622.161562228262;7672.424568157299;7687.846243075219;7695;7735.883961740691;6403.775867844603;6506.4469520091325;6542.247641521096;6779.966100169665;6794.8641027180165;7210.71157153708;7224.458165637493;7232.276772322725;7243.167035790952;7280.0535930328715;6543.738250470118;6652.401283884474;6724.260331363448;6822.249552549117;6925.722971081101;6667.766628167991;6723.630200339028;6769.627670478171;6804.455643548603;6884.793456196322;6671.733130674718;6759.797206083628;6790.490713196629;6797.93202067973;6807.591544507345;6079.361667024898;6168.9691551541955;6169;6174.907376389448;6179.474744646755;6355.237371515448;6356.77751278703;6360.904586431115;6361.681915904093;6365.681715914278 08:38:05 INFO - PROCESS | 24248 | |4;prototype.html;329.54522758593146;338.6850229286763;344.2151893682403;347.659293891986;354.9964500354997;6211.409916057979;6213.502919766419;6215.59598626089;6234.625922444651;6398.584092034014;6197.907031394533;6239.812805615838;6254.687265636723;6258.561900666955;6259.843503912404;4763.476017638057;4770.0459908018365;4770.0459908018365;4772.713637181763;4775.5463230993;4782.641301902354;4788.712677239359;4799.760011999386;4805.495422980589;4809.110314591811;4668.323093151491;4737.0525894821;4743.478217396084;4749.192637251658;4763.3093201485935;4723.622110231173;4739.668223224393;4739.73931433771;4741.739204343759;4754.619630429557;4113.560253911137;4129.256733787917;4130.958690413087;4131.690123240769;4139.296319625671;5912.793052243151;5943.881122377528;5945.672987985659;5954.196183515257;5972.134040564138;5371.274877891474;5489.34127904654;5523.1163013917985;5536.861578460531;5543.52880005196;6604.273529911706;6627.966860165717;6643.701033453506;6647.468202543785;6665.93334066658;4509.368688383629;4527.275635898273;4554.544545545452;4560.95439045612;4570.314452832068;6675.132232809752;6776.457883369319;6788.626625535593;6857.074294970165;6911.723531058751;4647.326137710013;4653.767311634405;4654.883627909329;4658.394408726844;4661.627069834405;4715.834945776881;4716.174669432836;4717.433907931001;4718.9292160617615;4720.386349774507;5455.236266922634;5484.369297530835;5495.203195536625;5496.093144631171;5505.752241149158;6372.808815735535;6598.142241508669;6656.70044847983;6658.733650654017;6710.966445167841;1630.5434478346083;1669.3823285384485;1684.3010150787286;1688.3415467967502;1691.458733205387;1083.8211695070383;1083.9241253112364;1087.8096333141668;1090.547422819521;1091.886275998493;6168.691565421711;6182.721777520022;6191.380861913863;6193.752249909953;6194.287656919512;6693.799186024427;6739.123913891162;6739.595624262462;6751.4261287790105;6761.121054263012;6081.118237855575;6179.16581261524;6188.566800324024;6196.132541444202;6207.131001659771;3666.2300916807767;3676.466912297702;3694.242680250542;3704.203596226824;3708.4622729704583;7003.824904377329;7066.787996360117;7084.149902011792;7086.7519636813495;7089.53917995339;6701.028350889093;6921.204061532888;6936.410405115622;6950.7567235147535;6956.443484521226;6975.232724400312;7005.0893383859775;7015.123109611299;7034;7048.436125110082;6708.060871478095;6719.395254427125;6734.9326506734305;6749.055132281583;6760.729570817309;6568.573042752206;6666.2333831609985;6683.365080317362;6692.297308782508;6699.899501507384;7066.328698773608;7069.681864316015;7070.7525236616475;7071.7878463646175;7080;4612.192866248326;4642.675012749075;4648.930266045944;4649.163150632919;4663.533646635309;6643.60138391698;6648.368405001517;6768.763093291711;6798.116244888133;6804.4216241620015;6677.198736151498;6677.2988836173445;6687.164104486939;6728.865422691617;6754.696038678369;6710.597364158166;6716.630585317855;6721.630310332783;6724.125863637696;6746.898796517958;6453.064305675557;6549.148610680581;6552.443042341454;6586.80239592813;6588.275289718223;6714.899276510954;6724.125863637696;6730.798076057726;6731.124953755981;6771.119754431892;6568.376004279586;6568.704408301543;6580.407763301135;6584.8024559263295;6597.472202223715 08:38:05 INFO - PROCESS | 24248 | |5;yui.html;761.6077719974214;771.6103367799265;778.9376849852013;789.7946533901184;834.1950018232404;13326.400311985959;13646.727065458685;13718.588442346732;13741.65645858854;13778.999999999987;12540.310282934457;12547.121701480877;12563.246205227693;12705.936470317658;12727.618171454847;789.6130895861015;796.5738329993469;797.09529683809;807.4307613132727;811.7118422959853;800.1358532784578;811.0308181722844;813.1299509524811;813.3046245460135;815.9388045896552;827.9296259817893;839.08539691736;845.8139209373928;847.4660963592959;847.6736456464243;825.6490991328691;836.2181360427988;837.1042984007084;837.3761547646981;838.3209600223777;609.1441524657863;609.2749627942734;611.2817439508559;614.7725341623583;616.1158737212115;13160.07879448439;13183.143095698844;13225.338733063309;13234.801477977839;13315.467381304736;11712.180147389687;12011.09916756238;12124;12257.461661078372;12678.87321126786;10454.738631534197;10477.790444191074;10563.947180264126;10573.20700947432;10601.84097238542;3504.528098198737;3596.352656521825;3601.8559257629663;3617.963820361789;3747.7563958342894;46451;46803.29795053077;47271.29093063607;47333.526664733254;47385.526144738455;8764.904386951632;9130.680426185052;9417.764555886157;9432.717018489457;9516.762080947894;16780.496585102468;16943.491695249162;17442.91278543599;17452.214650340764;17492.21285042176;7334.633268336562;7388.593627350548;7414.184439711627;7780.8832867507035;8029.237222463857;4313.460817397825;4372.081862808782;4466.240739074366;4505.144022635689;4512.706674066241;2863.441628882348;2899.8985035523656;2921.123662901121;2932.692067332942;2933.398653276073;514.7452011254378;523.5994464234864;524.7848382163295;526.3972751199931;527.1381291588281;555.7026990560031;563.5942121672389;566.9177969194526;639.2584601861818;646.4731244036095;7964.84070318602;7982.082060562993;8102.270795628422;8258.42191046621;8307.335413166933;592.1946153231602;601.1403692719454;646.6863571167979;679.3681875855502;737.8671839069019;3924.6075392460525;4134.359174327984;4354.782260886943;4364.770070148067;4420.381146639473;52960;53182.20226696603;54133.188002179995;54359.72820135874;54661;50103.24845127326;50333.24500132501;50431.49568504268;50515;50665.49334506682;44948;45279.773601132445;45379.09241815145;46203.306950395774;46384.304235436495;8709.520976346363;8900.376973611785;8904.599293031699;9092.272618190662;9176;33947.15132121717;34243;34278;34747.82626086853;35186.47220291749;42842;42914;43272.783636081615;43506.34740478832;43707;11071.50178241965;11164.776704466027;11216.270942388719;11254.493547790205;11372.43137843088;12277;12526.185797923106;12579.182353147016;12620.684482887635;13164.564555557252;11480.82778758336;11951.342676152895;12068.51725930988;12158.817617735564;12312.81530777057;10162.441065741456;10163.847542286723;10213.642522511676;10225.108354954356;10398.839811220105;11372.43137843088;11971.281723096643;12043.879561204276;12046;12405.875941240833;10011.449370284705;10124.797504050026;10265.384076955108;10392.116670083127;10418;9022.864657030019;9033.503157326148;9432.575534101119;9544.522773861418;9788.559514821993 08:38:05 INFO - PROCESS | 24248 | __end_tp_report 08:38:05 INFO - PROCESS | 24248 | __start_cc_report 08:38:05 INFO - PROCESS | 24248 | _x_x_mozilla_cycle_collect,314 08:38:05 INFO - PROCESS | 24248 | __end_cc_report 08:38:05 INFO - PROCESS | 24248 | __startTimestamp1452184685390__endTimestamp 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | ------- Summary: start ------- 08:38:05 INFO - PROCESS | 24248 | Number of tests: 6 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | [#0] dojo.html Cycles:165 Average:5308.88 Median:5521.00 stddev:596.03 (10.8%) stddev-sans-first:571.34 08:38:05 INFO - PROCESS | 24248 | Values: 3067.9 3112.0 3119.9 3141.3 3170.5 5181.3 5239.7 5264.9 5271.5 5307.2 5224.2 5224.7 5234.3 5268.4 5279.5 4839.7 4900.7 4918.1 4939.9 4953.9 4759.3 4950.1 4953.7 4977.7 4998.6 4851.6 4933.7 4934.3 4938.8 4987.3 4778.4 4794.8 4797.3 4826.2 4826.3 4693.3 4711.7 4797.2 4806.0 4859.5 5199.3 5211.3 5230.4 5260.2 5278.9 5748.9 5752.1 5770.3 5770.9 5826.3 5599.1 5696.6 5702.2 5766.2 5849.6 5372.1 5375.0 5394.5 5403.6 5411.4 5847.2 5895.4 5903.2 5912.6 5922.0 5507.6 5564.1 5605.8 5705.6 5747.7 5734.1 5742.7 5743.8 5745.3 5753.9 5694.2 5701.5 5706.5 5709.6 5725.6 5495.9 5558.9 5622.0 5673.5 5692.5 4394.7 4418.3 4422.1 4437.4 4470.0 3891.0 3933.8 3940.0 3947.4 3998.1 5323.8 5327.5 5373.9 5395.4 5449.9 5695.3 5740.6 5743.6 5763.7 5763.9 5273.8 5367.9 5373.6 5379.5 5431.1 4889.7 4903.8 4922.9 4936.0 4999.8 5762.9 5766.5 5774.4 5794.0 5803.9 5521.0 5583.2 5614.9 5697.8 5740.3 5998.3 6006.5 6011.3 6018.7 6028.5 5652.2 5710.7 5739.9 5742.7 5744.7 5598.1 5677.0 5712.9 5796.2 5812.4 5648.4 5650.4 5653.7 5654.2 5654.5 5649.1 5651.4 5652.8 5652.8 5655.4 5411.3 5433.7 5498.5 5540.0 5542.7 5538.0 5564.7 5572.7 5589.2 5608.9 5352.3 5498.3 5555.5 5563.2 5590.9 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | [#1] ext.html Cycles:180 Average:46679.83 Median:35364.00 stddev:82751.67 (234.0%) stddev-sans-first:82911.26 08:38:05 INFO - PROCESS | 24248 | Values: 527.9 555.0 568.4 580.8 588.5 34832.3 35345.0 35383.0 35456.8 35483.6 38195.0 38638.4 38800.0 38911.4 38995.0 8427.8 8567.5 8619.0 8620.8 8645.6 8424.6 8528.4 8553.0 8655.4 8707.0 8682.1 8762.9 8770.1 8794.2 8811.7 8692.2 8694.0 8721.0 8739.7 8756.5 8461.5 8581.8 8606.4 8624.7 8625.8 38730.6 39056.0 39200.6 39214.7 39235.6 3015.3 3172.5 3232.3 3302.7 3391.9 26012.5 26384.0 26395.6 26694.7 26741.0 3402.4 3424.0 3436.6 3508.2 3597.4 255175.0 255268.7 255832.0 255871.0 257930.0 40879.6 41715.4 61738.7 61950.7 62066.7 42949.1 43066.3 43284.8 43315.1 43492.1 13617.6 13817.2 13924.1 13942.7 13988.2 10788.9 10821.4 10823.6 10886.8 10900.7 14163.7 14253.6 14278.6 14351.0 14436.2 5710.9 5795.5 5819.9 5834.3 5848.4 891.9 897.4 947.9 970.9 977.3 25381.0 26175.0 26244.7 26488.6 30755.7 1005.9 1096.9 1128.4 1153.5 1155.9 15031.9 15295.1 15343.2 15434.2 15595.0 368662.0 374929.0 375101.0 375456.0 375851.0 54351.2 54444.5 54775.2 54973.5 54993.0 1325.4 1326.9 1335.4 1339.9 1439.0 27804.3 28911.0 29235.3 29408.0 29419.0 46263.1 46526.8 46736.8 47053.3 47120.0 302001.0 302838.0 303517.0 303579.0 305153.0 32691.3 42029.8 42266.0 42514.8 42645.1 38510.8 38666.2 39136.8 39455.8 40050.4 33681.0 33996.7 34132.5 34215.0 38922.4 33802.7 34293.8 34499.5 34608.7 35269.6 33474.7 33606.5 33614.8 33631.3 33838.8 30803.0 31466.5 31654.8 31691.0 31959.5 23856.9 24017.9 25257.5 25712.0 25935.0 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | [#2] jquery.html Cycles:180 Average:28728.77 Median:21300.36 stddev:91656.57 (430.3%) stddev-sans-first:91888.92 08:38:05 INFO - PROCESS | 24248 | Values: 353.2 354.7 357.8 359.8 362.0 16319.4 16850.6 17235.3 17903.1 17912.6 9915.1 10090.5 15438.2 15550.5 15612.1 4749.3 4749.5 4847.3 4867.4 4871.9 4835.2 4853.6 4853.7 4856.3 4878.2 4835.7 4851.9 5006.1 5181.1 5192.7 5103.4 5135.8 5141.9 5143.4 5167.8 5213.5 5255.8 5260.4 5271.8 5274.6 19831.0 19949.0 19976.3 20430.7 20454.0 2011.5 2027.6 2131.5 2170.2 2328.5 9046.8 9168.4 9269.8 9376.9 9571.9 1764.1 1808.2 1829.4 1846.4 1869.7 56572.0 58743.7 60666.4 60946.7 61799.7 10316.6 10430.2 10505.5 10512.2 10538.2 13319.1 13424.1 13441.5 13500.7 13509.5 7400.9 7407.0 7446.5 7519.1 7524.6 7021.6 7058.9 7099.9 7136.3 7146.6 4309.6 4369.9 4459.1 4515.3 4539.4 1836.9 1859.4 1860.0 1865.7 1880.4 400.9 406.9 417.2 437.4 454.7 10264.3 10663.9 10812.6 10823.9 10872.1 428.1 435.1 438.3 455.8 467.6 5911.6 5980.3 6067.2 6076.8 6095.3 549420.0 553323.7 563463.0 564490.0 570279.0 82276.6 83585.0 84042.0 84142.0 85250.6 451.4 1084.8 1119.5 1123.0 1129.1 14777.0 14913.3 15003.2 15112.8 15485.5 32517.2 32529.5 32997.5 33594.2 34014.0 42172.6 43165.8 43245.0 43780.3 44127.3 8947.6 9365.9 9433.7 9451.1 9457.8 10887.8 10999.6 11959.3 16137.1 16332.3 13233.1 13375.0 13745.2 14150.6 14751.9 13746.5 14026.9 14048.6 14355.9 14359.5 13939.7 14085.8 14447.0 14514.6 14696.3 8921.8 9172.6 9193.2 9226.8 9288.2 9630.2 10124.7 13461.3 13911.2 13917.3 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | [#3] mootools.html Cycles:180 Average:5189.88 Median:6358.84 stddev:2663.91 (41.9%) stddev-sans-first:2656.48 08:38:05 INFO - PROCESS | 24248 | Values: 1441.2 1449.4 1591.9 1705.9 1753.7 7314.2 7389.6 7527.5 7552.6 7559.3 7456.3 7490.3 7492.3 7518.1 7567.4 2160.2 2189.6 2190.0 2193.6 2196.4 2263.3 2290.4 2302.5 2307.3 2309.8 2176.9 2205.4 2228.1 2242.8 2245.1 2237.5 2258.9 2284.9 2285.2 2289.5 2275.9 2286.6 2291.2 2303.3 2306.9 7388.5 7447.1 7481.2 7496.2 7507.8 4482.1 4539.9 4588.3 4588.8 4593.4 2808.7 2896.9 2899.5 2907.3 2920.0 842.3 865.0 878.4 933.3 939.7 9955.0 10011.9 10025.4 10027.5 10041.9 3953.4 4023.6 4055.3 4057.0 4059.4 8306.6 8315.4 8329.9 8332.3 8336.1 4473.4 4486.5 4494.1 4526.3 4531.8 3976.3 4114.4 4118.7 4128.6 4132.8 3435.1 3462.5 3477.1 3499.3 3504.8 1075.2 1077.2 1082.2 1082.5 1085.0 1195.1 1195.7 1201.0 1302.6 1317.6 6921.1 6963.0 7003.0 7097.1 7137.5 446.9 450.3 451.9 453.4 456.6 5440.7 5498.0 5524.8 5551.2 5581.4 8700.5 8749.3 8871.6 8877.2 8972.4 8648.3 8683.4 8757.9 8764.5 8820.6 6866.4 6872.2 6896.9 6994.7 7039.8 6837.1 6855.0 6855.7 6860.9 6871.6 7560.1 7779.1 7779.9 7856.9 7938.2 7622.2 7672.4 7687.8 7695.0 7735.9 6403.8 6506.4 6542.2 6780.0 6794.9 7210.7 7224.5 7232.3 7243.2 7280.1 6543.7 6652.4 6724.3 6822.2 6925.7 6667.8 6723.6 6769.6 6804.5 6884.8 6671.7 6759.8 6790.5 6797.9 6807.6 6079.4 6169.0 6169.0 6174.9 6179.5 6355.2 6356.8 6360.9 6361.7 6365.7 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | [#4] prototype.html Cycles:180 Average:5515.09 Median:6209.27 stddev:1665.81 (26.8%) stddev-sans-first:1624.38 08:38:05 INFO - PROCESS | 24248 | Values: 329.5 338.7 344.2 347.7 355.0 6211.4 6213.5 6215.6 6234.6 6398.6 6197.9 6239.8 6254.7 6258.6 6259.8 4763.5 4770.0 4770.0 4772.7 4775.5 4782.6 4788.7 4799.8 4805.5 4809.1 4668.3 4737.1 4743.5 4749.2 4763.3 4723.6 4739.7 4739.7 4741.7 4754.6 4113.6 4129.3 4131.0 4131.7 4139.3 5912.8 5943.9 5945.7 5954.2 5972.1 5371.3 5489.3 5523.1 5536.9 5543.5 6604.3 6628.0 6643.7 6647.5 6665.9 4509.4 4527.3 4554.5 4561.0 4570.3 6675.1 6776.5 6788.6 6857.1 6911.7 4647.3 4653.8 4654.9 4658.4 4661.6 4715.8 4716.2 4717.4 4718.9 4720.4 5455.2 5484.4 5495.2 5496.1 5505.8 6372.8 6598.1 6656.7 6658.7 6711.0 1630.5 1669.4 1684.3 1688.3 1691.5 1083.8 1083.9 1087.8 1090.5 1091.9 6168.7 6182.7 6191.4 6193.8 6194.3 6693.8 6739.1 6739.6 6751.4 6761.1 6081.1 6179.2 6188.6 6196.1 6207.1 3666.2 3676.5 3694.2 3704.2 3708.5 7003.8 7066.8 7084.1 7086.8 7089.5 6701.0 6921.2 6936.4 6950.8 6956.4 6975.2 7005.1 7015.1 7034.0 7048.4 6708.1 6719.4 6734.9 6749.1 6760.7 6568.6 6666.2 6683.4 6692.3 6699.9 7066.3 7069.7 7070.8 7071.8 7080.0 4612.2 4642.7 4648.9 4649.2 4663.5 6643.6 6648.4 6768.8 6798.1 6804.4 6677.2 6677.3 6687.2 6728.9 6754.7 6710.6 6716.6 6721.6 6724.1 6746.9 6453.1 6549.1 6552.4 6586.8 6588.3 6714.9 6724.1 6730.8 6731.1 6771.1 6568.4 6568.7 6580.4 6584.8 6597.5 08:38:05 INFO - PROCESS | 24248 | 08:38:05 INFO - PROCESS | 24248 | [#5] yui.html Cycles:180 Average:13536.35 Median:24896.24 stddev:15410.75 (61.9%) stddev-sans-first:15424.12 08:38:05 INFO - PROCESS | 24248 | Values: 761.6 771.6 778.9 789.8 834.2 13326.4 13646.7 13718.6 13741.7 13779.0 12540.3 12547.1 12563.2 12705.9 12727.6 789.6 796.6 797.1 807.4 811.7 800.1 811.0 813.1 813.3 815.9 827.9 839.1 845.8 847.5 847.7 825.6 836.2 837.1 837.4 838.3 609.1 609.3 611.3 614.8 616.1 13160.1 13183.1 13225.3 13234.8 13315.5 11712.2 12011.1 12124.0 12257.5 12678.9 10454.7 10477.8 10563.9 10573.2 10601.8 3504.5 3596.4 3601.9 3618.0 3747.8 46451.0 46803.3 47271.3 47333.5 47385.5 8764.9 9130.7 9417.8 9432.7 9516.8 16780.5 16943.5 17442.9 17452.2 17492.2 7334.6 7388.6 7414.2 7780.9 8029.2 4313.5 4372.1 4466.2 4505.1 4512.7 2863.4 2899.9 2921.1 2932.7 2933.4 514.7 523.6 524.8 526.4 527.1 555.7 563.6 566.9 639.3 646.5 7964.8 7982.1 8102.3 8258.4 8307.3 592.2 601.1 646.7 679.4 737.9 3924.6 4134.4 4354.8 4364.8 4420.4 52960.0 53182.2 54133.2 54359.7 54661.0 50103.2 50333.2 50431.5 50515.0 50665.5 44948.0 45279.8 45379.1 46203.3 46384.3 8709.5 8900.4 8904.6 9092.3 9176.0 33947.2 34243.0 34278.0 34747.8 35186.5 42842.0 42914.0 43272.8 43506.3 43707.0 11071.5 11164.8 11216.3 11254.5 11372.4 12277.0 12526.2 12579.2 12620.7 13164.6 11480.8 11951.3 12068.5 12158.8 12312.8 10162.4 10163.8 10213.6 10225.1 10398.8 11372.4 11971.3 12043.9 12046.0 12405.9 10011.4 10124.8 10265.4 10392.1 10418.0 9022.9 9033.5 9432.6 9544.5 9788.6 08:38:05 INFO - PROCESS | 24248 | -------- Summary: end -------- 08:38:05 INFO - PROCESS | 24248 | 08:38:06 INFO - TEST-INFO | 24248: exit 0 08:38:06 INFO - TEST-OK | dromaeo_css | took 1110752ms 08:38:06 INFO - TEST-START | kraken 08:38:06 INFO - operating with platform_type : linux_ 08:38:06 INFO - Initialising browser for kraken test... 08:38:06 INFO - TEST-INFO | started process 24481 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgjNOVL/profile http://localhost:47973/getInfo.html) 08:38:09 INFO - PROCESS | 24481 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 08:38:10 INFO - PROCESS | 24481 | __metrics Screen width/height:1600/1200 08:38:10 INFO - PROCESS | 24481 | colorDepth:24 08:38:10 INFO - PROCESS | 24481 | Browser inner width/height: 1024/697 08:38:10 INFO - PROCESS | 24481 | __metrics 08:38:10 INFO - PROCESS | 24481 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:38:11 INFO - TEST-INFO | 24481: exit 0 08:38:11 INFO - Browser initialized. 08:38:11 INFO - Running cycle 1/1 for kraken test... 08:38:11 INFO - TEST-INFO | started process 24600 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgjNOVL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:23 INFO - PROCESS | 24600 | RSS: Main: 149721088 08:38:23 INFO - PROCESS | 24600 | 08:38:25 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47973/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:26 INFO - PROCESS | 24600 | RSS: Main: 151199744 08:38:26 INFO - PROCESS | 24600 | 08:38:29 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47973/tests/kraken/driver.html?testName=audio-dft) 08:38:29 INFO - PROCESS | 24600 | RSS: Main: 152174592 08:38:29 INFO - PROCESS | 24600 | 08:38:32 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47973/tests/kraken/driver.html?testName=audio-fft) 08:38:33 INFO - PROCESS | 24600 | RSS: Main: 145313792 08:38:33 INFO - PROCESS | 24600 | 08:38:35 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47973/tests/kraken/driver.html?testName=audio-oscillator) 08:38:35 INFO - PROCESS | 24600 | RSS: Main: 146493440 08:38:35 INFO - PROCESS | 24600 | 08:38:38 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47973/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:38 INFO - PROCESS | 24600 | RSS: Main: 146989056 08:38:38 INFO - PROCESS | 24600 | 08:38:41 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47973/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:42 INFO - PROCESS | 24600 | RSS: Main: 147156992 08:38:42 INFO - PROCESS | 24600 | 08:38:45 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47973/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:46 INFO - PROCESS | 24600 | RSS: Main: 148402176 08:38:46 INFO - PROCESS | 24600 | 08:38:48 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47973/tests/kraken/driver.html?testName=json-parse-financial) 08:38:49 INFO - PROCESS | 24600 | RSS: Main: 148586496 08:38:49 INFO - PROCESS | 24600 | 08:38:51 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47973/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:51 INFO - PROCESS | 24600 | RSS: Main: 149131264 08:38:51 INFO - PROCESS | 24600 | 08:38:53 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:54 INFO - PROCESS | 24600 | RSS: Main: 148946944 08:38:54 INFO - PROCESS | 24600 | 08:38:56 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:56 INFO - PROCESS | 24600 | RSS: Main: 148725760 08:38:56 INFO - PROCESS | 24600 | 08:38:59 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:59 INFO - PROCESS | 24600 | RSS: Main: 149544960 08:38:59 INFO - PROCESS | 24600 | 08:39:02 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:02 INFO - PROCESS | 24600 | RSS: Main: 148377600 08:39:02 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | Cycle 1(1): loaded http://localhost:47973/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47973/tests/kraken/driver.html?testName=ai-astar) 08:39:04 INFO - PROCESS | 24600 | RSS: Main: 148692992 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | __start_tp_report 08:39:04 INFO - PROCESS | 24600 | _x_x_mozilla_page_load 08:39:04 INFO - PROCESS | 24600 | _x_x_mozilla_page_load_details 08:39:04 INFO - PROCESS | 24600 | |i|pagename|runs| 08:39:04 INFO - PROCESS | 24600 | |0;ai-astar;111;108;112;110;112;123;112;111;110;114 08:39:04 INFO - PROCESS | 24600 | |1;audio-beat-detection;152;134;151;160;131;154;150;128;163;133 08:39:04 INFO - PROCESS | 24600 | |2;audio-dft;165;164;165;164;162;163;163;163;171;161 08:39:04 INFO - PROCESS | 24600 | |3;audio-fft;74;74;76;78;73;73;140;75;76;71 08:39:04 INFO - PROCESS | 24600 | |4;audio-oscillator;96;97;138;96;97;97;143;96;97;136 08:39:04 INFO - PROCESS | 24600 | |5;imaging-gaussian-blur;109;110;110;111;110;110;109;110;110;110 08:39:04 INFO - PROCESS | 24600 | |6;imaging-darkroom;147;147;147;146;148;146;147;146;146;147 08:39:04 INFO - PROCESS | 24600 | |7;imaging-desaturate;96;96;96;96;96;98;96;96;96;96 08:39:04 INFO - PROCESS | 24600 | |8;json-parse-financial;59;57;58;56;58;57;62;60;55;57 08:39:04 INFO - PROCESS | 24600 | |9;json-stringify-tinderbox;66;68;68;70;68;67;68;69;69;68 08:39:04 INFO - PROCESS | 24600 | |10;stanford-crypto-aes;84;84;92;85;87;86;86;85;93;86 08:39:04 INFO - PROCESS | 24600 | |11;stanford-crypto-ccm;129;119;115;133;128;128;118;116;120;123 08:39:04 INFO - PROCESS | 24600 | |12;stanford-crypto-pbkdf2;143;151;143;149;153;145;156;154;141;144 08:39:04 INFO - PROCESS | 24600 | |13;stanford-crypto-sha256-iterative;79;71;69;67;69;80;68;68;67;68 08:39:04 INFO - PROCESS | 24600 | __end_tp_report 08:39:04 INFO - PROCESS | 24600 | __start_cc_report 08:39:04 INFO - PROCESS | 24600 | _x_x_mozilla_cycle_collect,740 08:39:04 INFO - PROCESS | 24600 | __end_cc_report 08:39:04 INFO - PROCESS | 24600 | __startTimestamp1452184744936__endTimestamp 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | ------- Summary: start ------- 08:39:04 INFO - PROCESS | 24600 | Number of tests: 14 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.08 (3.6%) stddev-sans-first:4.30 08:39:04 INFO - PROCESS | 24600 | Values: 111.0 108.0 112.0 110.0 112.0 123.0 112.0 111.0 110.0 114.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:151.50 stddev:12.85 (8.5%) stddev-sans-first:13.42 08:39:04 INFO - PROCESS | 24600 | Values: 152.0 134.0 151.0 160.0 131.0 154.0 150.0 128.0 163.0 133.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.73 (1.7%) stddev-sans-first:2.87 08:39:04 INFO - PROCESS | 24600 | Values: 165.0 164.0 165.0 164.0 162.0 163.0 163.0 163.0 171.0 161.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.50 stddev:20.82 (27.9%) stddev-sans-first:21.93 08:39:04 INFO - PROCESS | 24600 | Values: 74.0 74.0 76.0 78.0 73.0 73.0 140.0 75.0 76.0 71.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:96.50 stddev:20.57 (21.3%) stddev-sans-first:21.25 08:39:04 INFO - PROCESS | 24600 | Values: 96.0 97.0 138.0 96.0 97.0 97.0 143.0 96.0 97.0 136.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 08:39:04 INFO - PROCESS | 24600 | Values: 109.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:39:04 INFO - PROCESS | 24600 | Values: 147.0 147.0 147.0 146.0 148.0 146.0 147.0 146.0 146.0 147.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:39:04 INFO - PROCESS | 24600 | Values: 96.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:2.02 (3.5%) stddev-sans-first:2.11 08:39:04 INFO - PROCESS | 24600 | Values: 59.0 57.0 58.0 56.0 58.0 57.0 62.0 60.0 55.0 57.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:0.87 08:39:04 INFO - PROCESS | 24600 | Values: 66.0 68.0 68.0 70.0 68.0 67.0 68.0 69.0 69.0 68.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.16 (3.7%) stddev-sans-first:3.18 08:39:04 INFO - PROCESS | 24600 | Values: 84.0 84.0 92.0 85.0 87.0 86.0 86.0 85.0 93.0 86.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:125.50 stddev:6.23 (5.0%) stddev-sans-first:6.20 08:39:04 INFO - PROCESS | 24600 | Values: 129.0 119.0 115.0 133.0 128.0 128.0 118.0 116.0 120.0 123.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.00 stddev:5.36 (3.6%) stddev-sans-first:5.39 08:39:04 INFO - PROCESS | 24600 | Values: 143.0 151.0 143.0 149.0 153.0 145.0 156.0 154.0 141.0 144.0 08:39:04 INFO - PROCESS | 24600 | 08:39:04 INFO - PROCESS | 24600 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:69.00 stddev:4.84 (7.0%) stddev-sans-first:4.06 08:39:04 INFO - PROCESS | 24600 | Values: 79.0 71.0 69.0 67.0 69.0 80.0 68.0 68.0 67.0 68.0 08:39:04 INFO - PROCESS | 24600 | -------- Summary: end -------- 08:39:04 INFO - PROCESS | 24600 | 08:39:05 INFO - TEST-INFO | 24600: exit 0 08:39:06 INFO - TEST-OK | kraken | took 59948ms 08:39:06 INFO - TEST-START | v8_7 08:39:06 INFO - operating with platform_type : linux_ 08:39:06 INFO - Initialising browser for v8_7 test... 08:39:06 INFO - TEST-INFO | started process 24888 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnQw8dx/profile http://localhost:47973/getInfo.html) 08:39:09 INFO - PROCESS | 24888 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 08:39:10 INFO - PROCESS | 24888 | __metrics Screen width/height:1600/1200 08:39:10 INFO - PROCESS | 24888 | colorDepth:24 08:39:10 INFO - PROCESS | 24888 | Browser inner width/height: 1024/697 08:39:10 INFO - PROCESS | 24888 | __metrics 08:39:10 INFO - PROCESS | 24888 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:39:11 INFO - TEST-INFO | 24888: exit 0 08:39:11 INFO - Browser initialized. 08:39:11 INFO - Running cycle 1/1 for v8_7 test... 08:39:11 INFO - TEST-INFO | started process 25009 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnQw8dx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:23 INFO - PROCESS | 25009 | RSS: Main: 150528000 08:39:23 INFO - PROCESS | 25009 | 08:39:44 INFO - PROCESS | 25009 | Cycle 1(1): loaded http://localhost:47973/tests/v8_7/run.html (next: http://localhost:47973/tests/v8_7/run.html) 08:39:45 INFO - PROCESS | 25009 | RSS: Main: 146976768 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | __start_tp_report 08:39:45 INFO - PROCESS | 25009 | _x_x_mozilla_page_load 08:39:45 INFO - PROCESS | 25009 | _x_x_mozilla_page_load_details 08:39:45 INFO - PROCESS | 25009 | |i|pagename|runs| 08:39:45 INFO - PROCESS | 25009 | |0;Richards;166.08536787908986 08:39:45 INFO - PROCESS | 25009 | |1;DeltaBlue;188.6080724254998 08:39:45 INFO - PROCESS | 25009 | |2;Encrypt;278.8622420524261 08:39:45 INFO - PROCESS | 25009 | |3;Decrypt;5251.308900523561 08:39:45 INFO - PROCESS | 25009 | |4;RayTrace;1078.7486515641856 08:39:45 INFO - PROCESS | 25009 | |5;Earley;762.7765064836003 08:39:45 INFO - PROCESS | 25009 | |6;Boyer;12180.722891566265 08:39:45 INFO - PROCESS | 25009 | |7;RegExp;25974.358974358973 08:39:45 INFO - PROCESS | 25009 | |8;Splay;688.7052341597796 08:39:45 INFO - PROCESS | 25009 | |9;NavierStokes;4822.115384615385 08:39:45 INFO - PROCESS | 25009 | __end_tp_report 08:39:45 INFO - PROCESS | 25009 | __startTimestamp1452184785114__endTimestamp 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | ------- Summary: start ------- 08:39:45 INFO - PROCESS | 25009 | Number of tests: 10 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 166.1 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#1] DeltaBlue Cycles:1 Average:188.61 Median:188.61 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 188.6 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 278.9 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 5251.3 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 1078.7 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#5] Earley Cycles:1 Average:762.78 Median:762.78 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 762.8 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 12180.7 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 25974.4 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#8] Splay Cycles:1 Average:688.71 Median:688.71 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 688.7 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - PROCESS | 25009 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 08:39:45 INFO - PROCESS | 25009 | Values: 4822.1 08:39:45 INFO - PROCESS | 25009 | -------- Summary: end -------- 08:39:45 INFO - PROCESS | 25009 | 08:39:45 INFO - TEST-INFO | 25009: exit 0 08:39:45 INFO - TEST-OK | v8_7 | took 39937ms 08:39:45 INFO - SUITE-END | took 1210s 08:39:46 INFO - Completed test suite (00:20:10) 08:39:46 INFO - Working with test: dromaeo_css 08:39:46 INFO - Generating results file: dromaeo_css 08:39:46 INFO - Working with test: kraken 08:39:46 INFO - Generating results file: kraken 08:39:46 INFO - javascript benchmark 08:39:46 INFO - Working with test: v8_7 08:39:46 INFO - Generating results file: v8_7 08:39:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:39:46 INFO - process_Request line: dromaeo_css 6778.46 graph.html#tests=[[72,64,43]] 08:39:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:46 INFO - process_Request line: kraken 1519.30 graph.html#tests=[[232,64,43]] 08:39:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:46 INFO - process_Request line: v8_7 20877.00 graph.html#tests=[[230,64,43]] 08:39:46 INFO - RETURN: dromaeo_css: 6778.46 08:39:46 INFO - RETURN: kraken: 1519.30 08:39:46 INFO - RETURN: v8_7: 20877.00 08:39:46 INFO - javascript benchmark 08:39:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3067.907962761117, 3112.0197137901546, 3119.8752049918003, 3141.308912039352, 3170.4610216263236, 5181.326427564421, 5239.711815850127, 5264.894702105965, 5271.472852714732, 5307.150855863063, 5224.1902505111675, 5224.686518808865, 5234.345706786652, 5268.446813084628, 5279.472052794728, 4839.709617422948, 4900.6569540132205, 4918.114739346916, 4939.851804445872, 4953.851384458472, 4759.309900064489, 4950.084234416627, 4953.653244272902, 4977.7262250576205, 4998.5501304882555, 4851.63612729045, 4933.728644924546, 4934.309196712463, 4938.789996450892, 4987.251912213179, 4778.4265888093305, 4794.808207671689, 4797.328374027639, 4826.155422801031, 4826.32431459596, 4693.296005599187, 4711.670183087185, 4797.160496913027, 4805.951940480585, 4859.465458799529, 5199.298094757197, 5211.348581427322, 5230.424653288135, 5260.237265596467, 5278.868028299324, 5748.8850222995725, 5752.0796672532615, 5770.307563092456, 5770.913436298459, 5826.329972053226, 5599.076152434844, 5696.629719068289, 5702.173184888209, 5766.163906233614, 5849.61977471463, 5372.140457526777, 5375.0, 5394.487523685244, 5403.648762830403, 5411.377691565481, 5847.152162936435, 5895.41045895407, 5903.203067585907, 5912.615679980788, 5921.970390148022, 5507.642003269774, 5564.054110801093, 5605.80379686709, 5705.62913410627, 5747.712614369265, 5734.082546792577, 5742.655440673573, 5743.827685169452, 5745.253117094751, 5753.913691294634, 5694.174344719992, 5701.458361455655, 5706.543476521868, 5709.600327977085, 5725.570582206351, 5495.945040549544, 5558.888822223533, 5622.044252477089, 5673.461021202979, 5692.544596432275, 4394.694441534596, 4418.270985287391, 4422.115576884572, 4437.423134992495, 4469.955300447019, 3891.0077930127636, 3933.8033098344968, 3940.0, 3947.388154836005, 3998.080441498472, 5323.840284791462, 5327.547158491494, 5373.892522149613, 5395.406505284415, 5449.863753406117, 5695.288088988877, 5740.598158128974, 5743.569232307594, 5763.711814409263, 5763.88472230553, 5273.789048438096, 5367.865803354947, 5373.623846330719, 5379.488948549882, 5431.103867861838, 4889.682170658967, 4903.754812259444, 4922.926156107661, 4935.975320123376, 4999.77501012448, 5762.942370576325, 5766.509846662997, 5774.422557744276, 5793.971030144907, 5803.88392232153, 5521.0, 5583.2462617547735, 5614.915776263441, 5697.800576979786, 5740.311162660508, 5998.25021872266, 6006.459418652167, 6011.308699499614, 6018.668973206516, 6028.547858910687, 5652.208690783212, 5710.743016564182, 5739.9139012915675, 5742.741576629145, 5744.741486633196, 5598.10430331145, 5676.971615141898, 5712.885742285214, 5796.21751063601, 5812.418758124323, 5648.406917273627, 5650.434956504317, 5653.717314134359, 5654.15187721845, 5654.519365853948, 5649.067903795828, 5651.378348381757, 5652.802151924663, 5652.802151924663, 5655.377908430151, 5411.269478620336, 5433.701146436984, 5498.505134537911, 5540.030494663337, 5542.722863856871, 5537.972310138423, 5564.666120032811, 5572.665640061447, 5589.217509548747, 5608.887822243614, 5352.330958630171, 5498.285222920995, 5555.527780138572, 5563.1655251710945, 5590.888182236414], "unit": "score", "name": "dojo.html", "value": 5269.361159609375}, {"lowerIsBetter": false, "replicates": [527.9076161671707, 554.9972250138749, 568.4258898512501, 580.7589850212162, 588.5203559099335, 34832.303353932904, 35345.0, 35383.0, 35456.82271588645, 35483.64516354835, 38195.0, 38638.420423693664, 38800.0, 38911.41632875509, 38995.0, 8427.789305267355, 8567.485950842969, 8619.0, 8620.827583448327, 8645.610947507377, 8424.578771061422, 8528.360372972022, 8553.0, 8655.437396569203, 8706.956465217665, 8682.088380720028, 8762.86082809234, 8770.079141690127, 8794.208521233088, 8811.691590794324, 8692.217700406962, 8694.0, 8721.0, 8739.737807865775, 8756.518391488466, 8461.450005749606, 8581.828363432758, 8606.440581362254, 8624.65501379944, 8625.827483450359, 38730.61269387298, 39056.0, 39200.607993919984, 39214.68638449768, 39235.60764392348, 3015.321552650636, 3172.524121381788, 3232.2565809863627, 3302.653221411765, 3391.8982430526876, 26012.479750405077, 26384.0, 26395.604065939027, 26694.73305266942, 26741.0, 3402.3535528249554, 3424.028127372236, 3436.60479044908, 3508.2457271686453, 3597.3524765542193, 255175.0, 255268.72365638238, 255832.0, 255871.0, 257929.99999999814, 40879.591204088174, 41715.37426938598, 61738.69130654318, 61950.69024654848, 62066.68966655138, 42949.14101717948, 43066.339361154656, 43284.78357608192, 43315.13369732588, 43492.13015739668, 13617.591472255848, 13817.240051797047, 13924.094933829268, 13942.721145577032, 13988.160710357412, 10788.946055269831, 10821.350718956888, 10823.56705731762, 10886.782264354826, 10900.727481812859, 14163.716725665636, 14253.64365890861, 14278.571642850731, 14351.0, 14436.206008669415, 5710.942890571041, 5795.478406943311, 5819.854503637443, 5834.3290521589715, 5848.444397782204, 891.9286457083417, 897.4032268541347, 947.9052094790466, 970.9368891022061, 977.3061126600194, 25381.0, 26175.0, 26244.73755262423, 26488.60267095995, 30755.69244307573, 1005.8692369992001, 1096.9286996345213, 1128.3906690387264, 1153.5155234801402, 1155.9190856639955, 15031.924840375728, 15295.093932152855, 15343.156126413154, 15434.15112168819, 15595.0, 368662.0, 374929.0, 375101.0, 375456.0, 375851.0, 54351.184732228256, 54444.45555544473, 54775.178372324444, 54973.45026549763, 54993.0, 1325.3770727757937, 1326.9004824637998, 1335.4190926946615, 1339.8928085753116, 1439.0286556574479, 27804.304892377044, 28911.0, 29235.269118271364, 29408.0, 29419.0, 46263.07473850571, 46526.76736616295, 46736.76631616956, 47053.294200587705, 47120.0, 302001.0, 302838.0, 303517.0, 303579.0, 305153.0, 32691.34617307688, 42029.78985105055, 42266.0, 42514.78742606267, 42645.14709705726, 38510.80744596259, 38666.22667546577, 39136.804315979374, 39455.80272098621, 40050.39924401078, 33681.0, 33996.66003340034, 34132.488012679336, 34215.0, 38922.416163757, 33802.66197337995, 34293.82853085719, 34499.4825077619, 34608.65391346054, 35269.64730352664, 33474.66525334716, 33606.49590256099, 33614.83192584021, 33631.3273734519, 33838.83080584581, 30803.0, 31466.528002080446, 31654.841725792146, 31691.0, 31959.520607191374, 23856.88071559631, 24017.91471515942, 25257.531874235337, 25712.0, 25935.0], "unit": "score", "name": "ext.html", "value": 17667.382350651955}, {"lowerIsBetter": false, "replicates": [353.15243415802087, 354.69673429218017, 357.7799653213273, 359.8254846399496, 361.9764715293506, 16319.428819991303, 16850.578735531617, 17235.310587576514, 17903.104844757774, 17912.552186195353, 9915.10764031237, 10090.486695915904, 15438.228088595553, 15550.533483995498, 15612.141332226724, 4749.335093086971, 4749.525047495249, 4847.345608342882, 4867.440244371907, 4871.926921096187, 4835.226363781796, 4853.587445067156, 4853.708777473363, 4856.271559266103, 4878.195097808857, 4835.709857408549, 4851.884066664669, 5006.148954677696, 5181.1192097343355, 5192.740362981855, 5103.438621751604, 5135.768890399941, 5141.897162056775, 5143.434222235551, 5167.7932882684645, 5213.4525874782985, 5255.789768409259, 5260.421353651095, 5271.815486457956, 5274.55166310864, 19831.0, 19949.0, 19976.3008294709, 20430.69353959677, 20454.0, 2011.517235863397, 2027.6248893954667, 2131.4884427737234, 2170.1861801824316, 2328.5342931413616, 9046.77383065422, 9168.358214924958, 9269.814603707888, 9376.8593471098, 9571.856422153603, 1764.126757255167, 1808.1682426084017, 1829.4145873320542, 1846.3630047633544, 1869.7382366468705, 56572.0, 58743.706281468316, 60666.39333606652, 60946.695266523384, 61799.69100154471, 10316.638917637847, 10430.16558675304, 10505.52725127371, 10512.21158413122, 10538.209634277306, 13319.067665263532, 13424.060315777997, 13441.462341506425, 13500.729985400238, 13509.459621615026, 7400.888986665204, 7406.962965185139, 7446.515976461513, 7519.060117485315, 7524.586147761816, 7021.648917554102, 7058.858822823515, 7099.858002840017, 7136.3220494052985, 7146.571205727673, 4309.612134907873, 4369.868903932887, 4459.10817836434, 4515.300128480091, 4539.432570928634, 1836.8714190006572, 1859.395696398676, 1859.9628007439776, 1865.6735071362457, 1880.3794747733216, 400.8516848765917, 406.8901396622895, 417.230210262066, 437.36363590975054, 454.6590057456907, 10264.281500294908, 10663.946680266548, 10812.56749730002, 10823.945880270549, 10872.075873550679, 428.14584903117856, 435.1080285414887, 438.27465544523864, 455.76072561905266, 467.60487388157634, 5911.556633252523, 5980.282366116007, 6067.2112625359305, 6076.848078797977, 6095.329513753483, 549420.0, 553323.7001444981, 563463.0, 564490.0, 570279.0, 82276.58861705773, 83585.0, 84042.0, 84142.0, 85250.57374713087, 451.36357735592657, 1084.7830433913248, 1119.535392811974, 1122.9887701123048, 1129.1136457880525, 14777.0, 14913.3289001993, 15003.174825384709, 15112.773308400603, 15485.458008969632, 32517.18707032343, 32529.512057319633, 32997.50503742494, 33594.160145996546, 34014.0, 42172.57827421809, 43165.76256780817, 43245.0, 43780.34329484997, 44127.33808992804, 8947.552622368725, 9365.906340936503, 9433.669821556212, 9451.05489451077, 9457.810843782949, 10887.782244355227, 10999.61501347449, 11959.342236177094, 16137.112458814878, 16332.346706132097, 13233.073684842353, 13375.0, 13745.175289482662, 14150.646233843825, 14751.92624036873, 13746.518871839438, 14026.929865350608, 14048.578542643738, 14355.856441435451, 14359.497417590333, 13939.651508711957, 14085.788713169515, 14447.0, 14514.63713407131, 14696.265186740835, 8921.821563568823, 9172.633094676405, 9193.218576421079, 9226.815463690822, 9288.164065234161, 9630.229581633592, 10124.69625911224, 13461.326933653474, 13911.165330080228, 13917.304134793423], "unit": "score", "name": "jquery.html", "value": 8002.39631062516}, {"lowerIsBetter": false, "replicates": [1441.2433472426978, 1449.4202319072374, 1591.9283632236547, 1705.9317627294909, 1753.6584512847683, 7314.232005639411, 7389.556626602401, 7527.548347099178, 7552.5846078465665, 7559.281868222523, 7456.291652293037, 7490.288422599844, 7492.250774922505, 7518.097828260617, 7567.394608431326, 2160.1899287767087, 2189.638709612912, 2190.036383991047, 2193.56128774245, 2196.374033400481, 2263.287064574662, 2290.393045842853, 2302.4934514406887, 2307.273208939179, 2309.7805708457668, 2176.912923483059, 2205.404540773998, 2228.097620463715, 2242.831787615927, 2245.090738251011, 2237.463008877874, 2258.8870556472193, 2284.8514846535004, 2285.177336158973, 2289.473421113153, 2275.8634481931135, 2286.6112760830697, 2291.175176936302, 2303.2974942642486, 2306.8731219782903, 7388.482806203568, 7447.069116360455, 7481.177070522238, 7496.212897645723, 7507.8498430031095, 4482.058767658796, 4539.909201815978, 4588.2888152336445, 4588.839390621346, 4593.448786145684, 2808.705085965985, 2896.898608548691, 2899.4635992341273, 2907.2877145099587, 2920.0217926994483, 842.3135144856922, 864.9740507784777, 878.3675753457501, 933.286036182321, 939.6805086270632, 9954.950225248827, 10011.949940250324, 10025.44860032698, 10027.548760305805, 10041.899581004169, 3953.446517487554, 4023.637872591481, 4055.3105971984833, 4057.046594050396, 4059.350503919418, 8306.626201820933, 8315.376346774015, 8329.875051874227, 8332.250097491255, 8336.083030866599, 4473.4408198975125, 4486.528914463999, 4494.056248187917, 4526.275795872644, 4531.77341132942, 3976.2842688315804, 4114.382842573638, 4118.732282401695, 4128.587141285848, 4132.793360331972, 3435.0725304167736, 3462.4806279058344, 3477.113336099329, 3499.3176330615283, 3504.7546671733244, 1075.2365820267541, 1077.2136340471343, 1082.1721383141903, 1082.4912291223113, 1084.9909584086718, 1195.1036722458157, 1195.677167164878, 1200.9939950300193, 1302.5571305756089, 1317.637649646355, 6921.134858142732, 6963.0, 7003.019577259086, 7097.112860892388, 7137.464690148259, 446.92849144136784, 450.2818005281571, 451.907358991406, 453.360761326528, 456.6050366433078, 5440.6735595864375, 5497.972510137423, 5524.751386187631, 5551.1673249012165, 5581.358143813513, 8700.521471319138, 8749.343799215085, 8871.556422178865, 8877.156670116328, 8972.37193396469, 8648.264897483785, 8683.435576687496, 8757.91242087571, 8764.5179515126, 8820.603072861737, 6866.416354609814, 6872.209695884937, 6896.931030689629, 6994.650267486605, 7039.788806335818, 6837.145356830396, 6855.0, 6855.725770969305, 6860.897086543806, 6871.622060786704, 7560.054993125859, 7779.105402878515, 7779.883301750591, 7856.882146767917, 7938.166492518433, 7622.161562228262, 7672.424568157299, 7687.846243075219, 7695.0, 7735.883961740691, 6403.775867844603, 6506.4469520091325, 6542.247641521096, 6779.966100169665, 6794.8641027180165, 7210.71157153708, 7224.458165637493, 7232.276772322725, 7243.167035790952, 7280.0535930328715, 6543.738250470118, 6652.401283884474, 6724.260331363448, 6822.249552549117, 6925.722971081101, 6667.766628167991, 6723.630200339028, 6769.627670478171, 6804.455643548603, 6884.793456196322, 6671.733130674718, 6759.797206083628, 6790.490713196629, 6797.93202067973, 6807.591544507345, 6079.361667024898, 6168.9691551541955, 6169.0, 6174.907376389448, 6179.474744646755, 6355.237371515448, 6356.77751278703, 6360.904586431115, 6361.681915904093, 6365.681715914278], "unit": "score", "name": "mootools.html", "value": 4207.097351824774}, {"lowerIsBetter": false, "replicates": [329.54522758593146, 338.6850229286763, 344.2151893682403, 347.659293891986, 354.9964500354997, 6211.409916057979, 6213.502919766419, 6215.59598626089, 6234.625922444651, 6398.584092034014, 6197.907031394533, 6239.812805615838, 6254.687265636723, 6258.561900666955, 6259.843503912404, 4763.476017638057, 4770.0459908018365, 4770.0459908018365, 4772.713637181763, 4775.5463230993, 4782.641301902354, 4788.712677239359, 4799.760011999386, 4805.495422980589, 4809.110314591811, 4668.323093151491, 4737.0525894821, 4743.478217396084, 4749.192637251658, 4763.3093201485935, 4723.622110231173, 4739.668223224393, 4739.73931433771, 4741.739204343759, 4754.619630429557, 4113.560253911137, 4129.256733787917, 4130.958690413087, 4131.690123240769, 4139.296319625671, 5912.793052243151, 5943.881122377528, 5945.672987985659, 5954.196183515257, 5972.134040564138, 5371.274877891474, 5489.34127904654, 5523.1163013917985, 5536.861578460531, 5543.52880005196, 6604.273529911706, 6627.966860165717, 6643.701033453506, 6647.468202543785, 6665.93334066658, 4509.368688383629, 4527.275635898273, 4554.544545545452, 4560.95439045612, 4570.314452832068, 6675.132232809752, 6776.457883369319, 6788.626625535593, 6857.074294970165, 6911.723531058751, 4647.326137710013, 4653.767311634405, 4654.883627909329, 4658.394408726844, 4661.627069834405, 4715.834945776881, 4716.174669432836, 4717.433907931001, 4718.9292160617615, 4720.386349774507, 5455.236266922634, 5484.369297530835, 5495.203195536625, 5496.093144631171, 5505.752241149158, 6372.808815735535, 6598.142241508669, 6656.70044847983, 6658.733650654017, 6710.966445167841, 1630.5434478346083, 1669.3823285384485, 1684.3010150787286, 1688.3415467967502, 1691.458733205387, 1083.8211695070383, 1083.9241253112364, 1087.8096333141668, 1090.547422819521, 1091.886275998493, 6168.691565421711, 6182.721777520022, 6191.380861913863, 6193.752249909953, 6194.287656919512, 6693.799186024427, 6739.123913891162, 6739.595624262462, 6751.4261287790105, 6761.121054263012, 6081.118237855575, 6179.16581261524, 6188.566800324024, 6196.132541444202, 6207.131001659771, 3666.2300916807767, 3676.466912297702, 3694.242680250542, 3704.203596226824, 3708.4622729704583, 7003.824904377329, 7066.787996360117, 7084.149902011792, 7086.7519636813495, 7089.53917995339, 6701.028350889093, 6921.204061532888, 6936.410405115622, 6950.7567235147535, 6956.443484521226, 6975.232724400312, 7005.0893383859775, 7015.123109611299, 7034.0, 7048.436125110082, 6708.060871478095, 6719.395254427125, 6734.9326506734305, 6749.055132281583, 6760.729570817309, 6568.573042752206, 6666.2333831609985, 6683.365080317362, 6692.297308782508, 6699.899501507384, 7066.328698773608, 7069.681864316015, 7070.7525236616475, 7071.7878463646175, 7080.0, 4612.192866248326, 4642.675012749075, 4648.930266045944, 4649.163150632919, 4663.533646635309, 6643.60138391698, 6648.368405001517, 6768.763093291711, 6798.116244888133, 6804.4216241620015, 6677.198736151498, 6677.2988836173445, 6687.164104486939, 6728.865422691617, 6754.696038678369, 6710.597364158166, 6716.630585317855, 6721.630310332783, 6724.125863637696, 6746.898796517958, 6453.064305675557, 6549.148610680581, 6552.443042341454, 6586.80239592813, 6588.275289718223, 6714.899276510954, 6724.125863637696, 6730.798076057726, 6731.124953755981, 6771.119754431892, 6568.376004279586, 6568.704408301543, 6580.407763301135, 6584.8024559263295, 6597.472202223715], "unit": "score", "name": "prototype.html", "value": 4968.722284270442}, {"lowerIsBetter": false, "replicates": [761.6077719974214, 771.6103367799265, 778.9376849852013, 789.7946533901184, 834.1950018232404, 13326.400311985959, 13646.727065458685, 13718.588442346732, 13741.65645858854, 13778.999999999987, 12540.310282934457, 12547.121701480877, 12563.246205227693, 12705.936470317658, 12727.618171454847, 789.6130895861015, 796.5738329993469, 797.09529683809, 807.4307613132727, 811.7118422959853, 800.1358532784578, 811.0308181722844, 813.1299509524811, 813.3046245460135, 815.9388045896552, 827.9296259817893, 839.08539691736, 845.8139209373928, 847.4660963592959, 847.6736456464243, 825.6490991328691, 836.2181360427988, 837.1042984007084, 837.3761547646981, 838.3209600223777, 609.1441524657863, 609.2749627942734, 611.2817439508559, 614.7725341623583, 616.1158737212115, 13160.07879448439, 13183.143095698844, 13225.338733063309, 13234.801477977839, 13315.467381304736, 11712.180147389687, 12011.09916756238, 12124.0, 12257.461661078372, 12678.87321126786, 10454.738631534197, 10477.790444191074, 10563.947180264126, 10573.20700947432, 10601.84097238542, 3504.528098198737, 3596.352656521825, 3601.8559257629663, 3617.963820361789, 3747.7563958342894, 46451.0, 46803.29795053077, 47271.29093063607, 47333.526664733254, 47385.526144738455, 8764.904386951632, 9130.680426185052, 9417.764555886157, 9432.717018489457, 9516.762080947894, 16780.496585102468, 16943.491695249162, 17442.91278543599, 17452.214650340764, 17492.21285042176, 7334.633268336562, 7388.593627350548, 7414.184439711627, 7780.8832867507035, 8029.237222463857, 4313.460817397825, 4372.081862808782, 4466.240739074366, 4505.144022635689, 4512.706674066241, 2863.441628882348, 2899.8985035523656, 2921.123662901121, 2932.692067332942, 2933.398653276073, 514.7452011254378, 523.5994464234864, 524.7848382163295, 526.3972751199931, 527.1381291588281, 555.7026990560031, 563.5942121672389, 566.9177969194526, 639.2584601861818, 646.4731244036095, 7964.84070318602, 7982.082060562993, 8102.270795628422, 8258.42191046621, 8307.335413166933, 592.1946153231602, 601.1403692719454, 646.6863571167979, 679.3681875855502, 737.8671839069019, 3924.6075392460525, 4134.359174327984, 4354.782260886943, 4364.770070148067, 4420.381146639473, 52960.0, 53182.20226696603, 54133.188002179995, 54359.72820135874, 54661.0, 50103.24845127326, 50333.24500132501, 50431.49568504268, 50515.0, 50665.49334506682, 44948.0, 45279.773601132445, 45379.09241815145, 46203.306950395774, 46384.304235436495, 8709.520976346363, 8900.376973611785, 8904.599293031699, 9092.272618190662, 9176.0, 33947.15132121717, 34243.0, 34278.0, 34747.82626086853, 35186.47220291749, 42842.0, 42914.0, 43272.783636081615, 43506.34740478832, 43707.0, 11071.50178241965, 11164.776704466027, 11216.270942388719, 11254.493547790205, 11372.43137843088, 12277.0, 12526.185797923106, 12579.182353147016, 12620.684482887635, 13164.564555557252, 11480.82778758336, 11951.342676152895, 12068.51725930988, 12158.817617735564, 12312.81530777057, 10162.441065741456, 10163.847542286723, 10213.642522511676, 10225.108354954356, 10398.839811220105, 11372.43137843088, 11971.281723096643, 12043.879561204276, 12046.0, 12405.875941240833, 10011.449370284705, 10124.797504050026, 10265.384076955108, 10392.116670083127, 10418.0, 9022.864657030019, 9033.503157326148, 9432.575534101119, 9544.522773861418, 9788.559514821993], "unit": "score", "name": "yui.html", "value": 6228.3426025305}], "name": "dromaeo_css", "value": 6778.462571499427}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 110.0, 112.0, 123.0, 112.0, 111.0, 110.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [152.0, 134.0, 151.0, 160.0, 131.0, 154.0, 150.0, 128.0, 163.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 165.0, 164.0, 162.0, 163.0, 163.0, 163.0, 171.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 76.0, 78.0, 73.0, 73.0, 140.0, 75.0, 76.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 138.0, 96.0, 97.0, 97.0, 143.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 56.0, 58.0, 57.0, 62.0, 60.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 70.0, 68.0, 67.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 92.0, 85.0, 87.0, 86.0, 86.0, 85.0, 93.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 115.0, 133.0, 128.0, 128.0, 118.0, 116.0, 120.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [143.0, 151.0, 143.0, 149.0, 153.0, 145.0, 156.0, 154.0, 141.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [79.0, 71.0, 69.0, 67.0, 69.0, 80.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1519.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [188.6080724254998], "unit": "score", "name": "DeltaBlue", "value": 350.5576359999999}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [762.7765064836003], "unit": "score", "name": "Earley", "value": 873.732993}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [688.7052341597796], "unit": "score", "name": "Splay", "value": 118.32493200000005}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20876.99728154199}]} 08:39:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20877.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1519.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6778.46"}}} 08:39:46 INFO - Return code: 0 08:39:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:39:46 INFO - # TBPL SUCCESS # 08:39:46 INFO - Running post-action listener: _resource_record_post_action 08:39:46 INFO - Running post-run listener: _resource_record_post_run 08:39:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 564195328; Read time: 0; Write time: 496872 08:39:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239038464; Read time: 0; Write time: 272916 08:39:47 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 324866048; Read time: 0; Write time: 223936 08:39:47 INFO - Running post-run listener: _upload_blobber_files 08:39:47 INFO - Blob upload gear active. 08:39:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:39:47 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 08:39:47 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'] 08:39:47 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 08:39:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:48 INFO - (blobuploader) - INFO - Done attempting. 08:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:49 INFO - (blobuploader) - INFO - Done attempting. 08:39:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:49 INFO - Return code: 0 08:39:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:39:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6bbdf77a48fb9a09c42d6f0d38134137556ecc0c393706a6ddcd744e31153d511207f29378423c012eaab9e689b72e920e751a7beb6f71b394790ec44e93a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c11dfd77da3d0df5b2941eed8230f78f97aaddbeac62d151eed7e79dd52cbbf34d447d2b06c67562db4faa83f76e658205d65beb15321e0c82c7a39d1085607"} 08:39:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:39:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:39:49 INFO - Contents: 08:39:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6bbdf77a48fb9a09c42d6f0d38134137556ecc0c393706a6ddcd744e31153d511207f29378423c012eaab9e689b72e920e751a7beb6f71b394790ec44e93a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c11dfd77da3d0df5b2941eed8230f78f97aaddbeac62d151eed7e79dd52cbbf34d447d2b06c67562db4faa83f76e658205d65beb15321e0c82c7a39d1085607"} 08:39:49 INFO - Copying logs to upload dir... 08:39:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.628590 ========= master_lag: 12.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-07 08:40:01.747850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:40:01.751733) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6bbdf77a48fb9a09c42d6f0d38134137556ecc0c393706a6ddcd744e31153d511207f29378423c012eaab9e689b72e920e751a7beb6f71b394790ec44e93a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c11dfd77da3d0df5b2941eed8230f78f97aaddbeac62d151eed7e79dd52cbbf34d447d2b06c67562db4faa83f76e658205d65beb15321e0c82c7a39d1085607"} build_url:https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6bbdf77a48fb9a09c42d6f0d38134137556ecc0c393706a6ddcd744e31153d511207f29378423c012eaab9e689b72e920e751a7beb6f71b394790ec44e93a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c11dfd77da3d0df5b2941eed8230f78f97aaddbeac62d151eed7e79dd52cbbf34d447d2b06c67562db4faa83f76e658205d65beb15321e0c82c7a39d1085607"}' ========= master_lag: 0.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:40:01.975412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:40:01.975771) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452178563.226854-761248418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:40:01.992158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:40:01.992571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:40:01.992885) ========= ========= Total master_lag: 12.58 =========