builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1451409749.26 results: success (0) buildid: 20151229070358 builduid: e2919b9583084cc9a8575b3ce4b19da5 revision: 0b0ad49b43179dcc416b81be4a08c5a8526977df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.260955) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.261459) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.261934) ========= 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006346 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.318857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.319155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.387367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.387642) ========= 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.437371) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.437688) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.438097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.438418) ========= 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 09:22: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% 229M=0s 2015-12-29 09:22:30 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.654934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.655328) ========= 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019448 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:29.705874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-29 09:22:29.706216) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b0ad49b43179dcc416b81be4a08c5a8526977df --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b0ad49b43179dcc416b81be4a08c5a8526977df --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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 09:22:30,253 truncating revision to first 12 chars 2015-12-29 09:22:30,253 Setting DEBUG logging. 2015-12-29 09:22:30,253 attempt 1/10 2015-12-29 09:22:30,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0b0ad49b4317?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 09:22:31,226 unpacking tar archive at: mozilla-aurora-0b0ad49b4317/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-29 09:22:30.974955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:30.975281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:30.983561) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:30.983985) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 09:22:30.984503) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-29 09:22:30.984814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:31 INFO - MultiFileLogger online at 20151229 09:22:31 in /builds/slave/test-pgo 09:22:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:22:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:22:31 INFO - {'append_to_log': False, 09:22:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:22:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:22:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:22:31 INFO - 'branch': 'Mozilla-Aurora', 09:22:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:31 INFO - 'config_files': ('talos/linux_config.py',), 09:22:31 INFO - 'default_actions': ('clobber', 09:22:31 INFO - 'read-buildbot-config', 09:22:31 INFO - 'download-and-extract', 09:22:31 INFO - 'populate-webroot', 09:22:31 INFO - 'create-virtualenv', 09:22:31 INFO - 'install', 09:22:31 INFO - 'run-tests'), 09:22:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:31 INFO - 'download_minidump_stackwalk': True, 09:22:31 INFO - 'download_symbols': 'ondemand', 09:22:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:31 INFO - 'installer_path': 'installer.exe', 09:22:31 INFO - 'log_level': 'info', 09:22:31 INFO - 'log_name': 'talos', 09:22:31 INFO - 'log_to_console': True, 09:22:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:31 INFO - 'opt_config_files': (), 09:22:31 INFO - 'pip_index': False, 09:22:31 INFO - 'sps_profile': False, 09:22:31 INFO - 'sps_profile_interval': 0, 09:22:31 INFO - 'suite': 'dromaeojs-e10s', 09:22:31 INFO - 'system_bits': '32', 09:22:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:31 INFO - 'title': 'talos-linux64-ix-047', 09:22:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:31 INFO - 'use_talos_json': True, 09:22:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:22:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:31 INFO - 'work_dir': 'build'} 09:22:31 INFO - ##### 09:22:31 INFO - ##### Running clobber step. 09:22:31 INFO - ##### 09:22:31 INFO - Running pre-action listener: _resource_record_pre_action 09:22:31 INFO - Running main action method: clobber 09:22:31 INFO - rmtree: /builds/slave/test-pgo/build 09:22:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:22:32 INFO - Running post-action listener: _resource_record_post_action 09:22:32 INFO - ##### 09:22:32 INFO - ##### Running read-buildbot-config step. 09:22:32 INFO - ##### 09:22:32 INFO - Running pre-action listener: _resource_record_pre_action 09:22:32 INFO - Running main action method: read_buildbot_config 09:22:32 INFO - Using buildbot properties: 09:22:32 INFO - { 09:22:32 INFO - "properties": { 09:22:32 INFO - "buildnumber": 26, 09:22:32 INFO - "product": "firefox", 09:22:32 INFO - "script_repo_revision": "production", 09:22:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:22:32 INFO - "repository": "", 09:22:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:22:32 INFO - "buildid": "20151229070358", 09:22:32 INFO - "slavename": "talos-linux64-ix-047", 09:22:32 INFO - "pgo_build": "True", 09:22:32 INFO - "basedir": "/builds/slave/test-pgo", 09:22:32 INFO - "project": "", 09:22:32 INFO - "platform": "ubuntu64_hw", 09:22:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:22:32 INFO - "slavebuilddir": "test", 09:22:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:22:32 INFO - "branch": "mozilla-aurora", 09:22:32 INFO - "repo_path": "releases/mozilla-aurora", 09:22:32 INFO - "stage_platform": "linux64-pgo", 09:22:32 INFO - "builduid": "e2919b9583084cc9a8575b3ce4b19da5", 09:22:32 INFO - "revision": "0b0ad49b43179dcc416b81be4a08c5a8526977df" 09:22:32 INFO - }, 09:22:32 INFO - "sourcestamp": { 09:22:32 INFO - "repository": "", 09:22:32 INFO - "hasPatch": false, 09:22:32 INFO - "project": "", 09:22:32 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:22:32 INFO - "changes": [ 09:22:32 INFO - { 09:22:32 INFO - "category": null, 09:22:32 INFO - "files": [ 09:22:32 INFO - { 09:22:32 INFO - "url": null, 09:22:32 INFO - "name": "https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:22:32 INFO - } 09:22:32 INFO - ], 09:22:32 INFO - "repository": "", 09:22:32 INFO - "rev": "0b0ad49b43179dcc416b81be4a08c5a8526977df", 09:22:32 INFO - "who": "mleibovic@mozilla.com", 09:22:32 INFO - "when": 1451409726, 09:22:32 INFO - "number": 7400044, 09:22:32 INFO - "comments": "Bug 1234238 - Restore FFB theme. r=sebastian a=sledru", 09:22:32 INFO - "project": "", 09:22:32 INFO - "at": "Tue 29 Dec 2015 09:22:06", 09:22:32 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:22:32 INFO - "revlink": "", 09:22:32 INFO - "properties": [ 09:22:32 INFO - [ 09:22:32 INFO - "buildid", 09:22:32 INFO - "20151229070358", 09:22:32 INFO - "Change" 09:22:32 INFO - ], 09:22:32 INFO - [ 09:22:32 INFO - "builduid", 09:22:32 INFO - "e2919b9583084cc9a8575b3ce4b19da5", 09:22:32 INFO - "Change" 09:22:32 INFO - ], 09:22:32 INFO - [ 09:22:32 INFO - "pgo_build", 09:22:32 INFO - "True", 09:22:32 INFO - "Change" 09:22:32 INFO - ] 09:22:32 INFO - ], 09:22:32 INFO - "revision": "0b0ad49b43179dcc416b81be4a08c5a8526977df" 09:22:32 INFO - } 09:22:32 INFO - ], 09:22:32 INFO - "revision": "0b0ad49b43179dcc416b81be4a08c5a8526977df" 09:22:32 INFO - } 09:22:32 INFO - } 09:22:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:22:32 INFO - Running post-action listener: _resource_record_post_action 09:22:32 INFO - ##### 09:22:32 INFO - ##### Running download-and-extract step. 09:22:32 INFO - ##### 09:22:32 INFO - Running pre-action listener: _resource_record_pre_action 09:22:32 INFO - Running main action method: download_and_extract 09:22:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:22: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')]} 09:22:32 INFO - https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:22:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/test_packages.json 09:22:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/test_packages.json 09:22:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:22:32 INFO - Downloaded 1302 bytes. 09:22:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:22:32 INFO - Using the following test package requirements: 09:22:32 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:32 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:22:32 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'jsshell-linux-x86_64.zip'], 09:22:32 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:22:32 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:32 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:22:32 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:22:32 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:22:32 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:32 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:32 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:22:32 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:22: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')]} 09:22:32 INFO - https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:22:33 INFO - Downloaded 23022657 bytes. 09:22:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:22:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:22:34 INFO - Return code: 0 09:22:34 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:22: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')]} 09:22:34 INFO - https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:22:44 INFO - Downloaded 23022657 bytes. 09:22:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:22:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:22:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:22:45 INFO - Return code: 0 09:22:45 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')]} 09:22:45 INFO - https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:22:46 INFO - Downloaded 11132038 bytes. 09:22:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:22:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:22:46 INFO - Return code: 0 09:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:46 INFO - https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:22:47 INFO - Downloaded 58088252 bytes. 09:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:22:47 INFO - mkdir: /builds/slave/test-pgo/properties 09:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:22:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:22:47 INFO - Contents: 09:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:22:47 INFO - Running post-action listener: _resource_record_post_action 09:22:47 INFO - Running post-action listener: set_extra_try_arguments 09:22:47 INFO - ##### 09:22:47 INFO - ##### Running populate-webroot step. 09:22:47 INFO - ##### 09:22:47 INFO - Running pre-action listener: _resource_record_pre_action 09:22:47 INFO - Running main action method: populate_webroot 09:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:47 INFO - '--tppagecycles', 09:22:47 INFO - '7'], 09:22:47 INFO - 'tests': ['tsvgm']}}, 09:22:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:22:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:22:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'tests': ['damp', 'tps']}, 09:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['damp', 'tps']}, 09:22:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:47 INFO - 'other': {'tests': ['a11yr', 09:22:47 INFO - 'ts_paint', 09:22:47 INFO - 'tpaint', 09:22:47 INFO - 'sessionrestore', 09:22:47 INFO - 'sessionrestore_no_auto_restore']}, 09:22:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['a11yr', 09:22:47 INFO - 'ts_paint', 09:22:47 INFO - 'tpaint', 09:22:47 INFO - 'sessionrestore', 09:22:47 INFO - 'sessionrestore_no_auto_restore']}, 09:22:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['a11yr', 09:22:47 INFO - 'ts_paint', 09:22:47 INFO - 'tpaint', 09:22:47 INFO - 'sessionrestore', 09:22:47 INFO - 'sessionrestore_no_auto_restore']}, 09:22:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['a11yr', 09:22:47 INFO - 'ts_paint', 09:22:47 INFO - 'tpaint', 09:22:47 INFO - 'sessionrestore', 09:22:47 INFO - 'sessionrestore_no_auto_restore']}, 09:22:47 INFO - 'other_l64': {'tests': ['a11yr', 09:22:47 INFO - 'ts_paint', 09:22:47 INFO - 'tpaint', 09:22:47 INFO - 'sessionrestore', 09:22:47 INFO - 'sessionrestore_no_auto_restore']}, 09:22:47 INFO - 'other_nol64': {'tests': ['a11yr', 09:22:47 INFO - 'ts_paint', 09:22:47 INFO - 'tpaint', 09:22:47 INFO - 'sessionrestore', 09:22:47 INFO - 'sessionrestore_no_auto_restore']}, 09:22:47 INFO - 'svgr': {'tests': ['tsvgx', 09:22:47 INFO - 'tsvgr_opacity', 09:22:47 INFO - 'tart', 09:22:47 INFO - 'tscrollx', 09:22:47 INFO - 'cart']}, 09:22:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['tsvgx', 09:22:47 INFO - 'tsvgr_opacity', 09:22:47 INFO - 'tart', 09:22:47 INFO - 'tscrollx', 09:22:47 INFO - 'cart']}, 09:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'tests': ['tp5o']}, 09:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'talos_options': ['--e10s'], 09:22:47 INFO - 'tests': ['tp5o']}, 09:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'talos_options': ['--xperf_path', 09:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:47 INFO - 'tests': ['tp5n']}, 09:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:47 INFO - 'talos_options': ['--e10s', 09:22:47 INFO - '--xperf_path', 09:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:47 INFO - 'tests': ['tp5n']}}, 09:22:47 INFO - 'talos.zip': {'path': '', 09:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:47 INFO - Running post-action listener: _resource_record_post_action 09:22:47 INFO - ##### 09:22:47 INFO - ##### Running create-virtualenv step. 09:22:47 INFO - ##### 09:22:47 INFO - Running pre-action listener: _resource_record_pre_action 09:22:47 INFO - Running main action method: create_virtualenv 09:22:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:22:47 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 09:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:47 INFO - Using real prefix '/usr' 09:22:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:22:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:50 INFO - Installing pip.................done. 09:22:50 INFO - Return code: 0 09:22:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:22:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:22:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:22:50 INFO - Using env: {'DISPLAY': ':0', 09:22:50 INFO - 'HOME': '/home/cltbld', 09:22:50 INFO - 'LANG': 'en_US.UTF-8', 09:22:50 INFO - 'LANGUAGE': 'en_US:en', 09:22:50 INFO - 'LOGNAME': 'cltbld', 09:22:50 INFO - 'MAIL': '/var/mail/cltbld', 09:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:50 INFO - 'MOZ_NO_REMOTE': '1', 09:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:50 INFO - 'NO_EM_RESTART': '1', 09:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:50 INFO - 'SHELL': '/bin/bash', 09:22:50 INFO - 'SHLVL': '1', 09:22:50 INFO - 'TERM': 'linux', 09:22:50 INFO - 'TMOUT': '86400', 09:22:50 INFO - 'USER': 'cltbld', 09:22:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:50 INFO - '_': '/tools/buildbot/bin/python'} 09:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:50 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 09:22:50 INFO - Cleaning up... 09:22:50 INFO - Return code: 0 09:22:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:22:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:22:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:22:50 INFO - Using env: {'DISPLAY': ':0', 09:22:50 INFO - 'HOME': '/home/cltbld', 09:22:50 INFO - 'LANG': 'en_US.UTF-8', 09:22:50 INFO - 'LANGUAGE': 'en_US:en', 09:22:50 INFO - 'LOGNAME': 'cltbld', 09:22:50 INFO - 'MAIL': '/var/mail/cltbld', 09:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:50 INFO - 'MOZ_NO_REMOTE': '1', 09:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:50 INFO - 'NO_EM_RESTART': '1', 09:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:50 INFO - 'SHELL': '/bin/bash', 09:22:50 INFO - 'SHLVL': '1', 09:22:50 INFO - 'TERM': 'linux', 09:22:50 INFO - 'TMOUT': '86400', 09:22:50 INFO - 'USER': 'cltbld', 09:22:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:50 INFO - '_': '/tools/buildbot/bin/python'} 09:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:50 INFO - Downloading/unpacking psutil>=0.7.1 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:50 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 09:22:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:22:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:22:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:52 INFO - Installing collected packages: psutil 09:22:52 INFO - Running setup.py install for psutil 09:22:52 INFO - building 'psutil._psutil_linux' extension 09:22:52 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 09:22:52 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 09:22:53 INFO - building 'psutil._psutil_posix' extension 09:22:53 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 09:22:53 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 09:22:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:53 INFO - Successfully installed psutil 09:22:53 INFO - Cleaning up... 09:22:53 INFO - Return code: 0 09:22:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:22:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:22:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:22:53 INFO - Using env: {'DISPLAY': ':0', 09:22:53 INFO - 'HOME': '/home/cltbld', 09:22:53 INFO - 'LANG': 'en_US.UTF-8', 09:22:53 INFO - 'LANGUAGE': 'en_US:en', 09:22:53 INFO - 'LOGNAME': 'cltbld', 09:22:53 INFO - 'MAIL': '/var/mail/cltbld', 09:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:53 INFO - 'MOZ_NO_REMOTE': '1', 09:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:53 INFO - 'NO_EM_RESTART': '1', 09:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:53 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:53 INFO - 'SHELL': '/bin/bash', 09:22:53 INFO - 'SHLVL': '1', 09:22:53 INFO - 'TERM': 'linux', 09:22:53 INFO - 'TMOUT': '86400', 09:22:53 INFO - 'USER': 'cltbld', 09:22:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:53 INFO - '_': '/tools/buildbot/bin/python'} 09:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:22:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:22:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:22:55 INFO - Installing collected packages: mozsystemmonitor 09:22:55 INFO - Running setup.py install for mozsystemmonitor 09:22:55 INFO - Successfully installed mozsystemmonitor 09:22:55 INFO - Cleaning up... 09:22:55 INFO - Return code: 0 09:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:22:55 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')]} 09:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:55 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')]} 09:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:55 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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:22:55 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 09:22:55 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 09:22:55 INFO - Using env: {'DISPLAY': ':0', 09:22:55 INFO - 'HOME': '/home/cltbld', 09:22:55 INFO - 'LANG': 'en_US.UTF-8', 09:22:55 INFO - 'LANGUAGE': 'en_US:en', 09:22:55 INFO - 'LOGNAME': 'cltbld', 09:22:55 INFO - 'MAIL': '/var/mail/cltbld', 09:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:55 INFO - 'MOZ_NO_REMOTE': '1', 09:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:55 INFO - 'NO_EM_RESTART': '1', 09:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:55 INFO - 'SHELL': '/bin/bash', 09:22:55 INFO - 'SHLVL': '1', 09:22:55 INFO - 'TERM': 'linux', 09:22:55 INFO - 'TMOUT': '86400', 09:22:55 INFO - 'USER': 'cltbld', 09:22:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:55 INFO - '_': '/tools/buildbot/bin/python'} 09:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:22:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:22:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:22:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:57 INFO - Downloading docopt-0.6.1.tar.gz 09:22:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:22:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:58 INFO - Running setup.py install for blobuploader 09:22:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:22:58 INFO - Running setup.py install for requests 09:22:58 INFO - Running setup.py install for docopt 09:22:58 INFO - Successfully installed blobuploader requests docopt 09:22:58 INFO - Cleaning up... 09:22:58 INFO - Return code: 0 09:22:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22:58 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')]} 09:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:58 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')]} 09:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:58 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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:22:58 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 09:22:58 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 09:22:58 INFO - Using env: {'DISPLAY': ':0', 09:22:58 INFO - 'HOME': '/home/cltbld', 09:22:58 INFO - 'LANG': 'en_US.UTF-8', 09:22:58 INFO - 'LANGUAGE': 'en_US:en', 09:22:58 INFO - 'LOGNAME': 'cltbld', 09:22:58 INFO - 'MAIL': '/var/mail/cltbld', 09:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:58 INFO - 'MOZ_NO_REMOTE': '1', 09:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:58 INFO - 'NO_EM_RESTART': '1', 09:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:58 INFO - 'SHELL': '/bin/bash', 09:22:58 INFO - 'SHLVL': '1', 09:22:58 INFO - 'TERM': 'linux', 09:22:58 INFO - 'TMOUT': '86400', 09:22:58 INFO - 'USER': 'cltbld', 09:22:58 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:58 INFO - '_': '/tools/buildbot/bin/python'} 09:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:58 INFO - Running setup.py (path:/tmp/pip-dJyTL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:58 INFO - Running setup.py (path:/tmp/pip-ORoQ1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:58 INFO - Running setup.py (path:/tmp/pip-5SnF3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:59 INFO - Running setup.py (path:/tmp/pip-Iabjfa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:59 INFO - Running setup.py (path:/tmp/pip-jhDpFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:59 INFO - Running setup.py (path:/tmp/pip-HlqJKP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:59 INFO - Running setup.py (path:/tmp/pip-sAXl8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:59 INFO - Running setup.py (path:/tmp/pip-u54D9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:59 INFO - Running setup.py (path:/tmp/pip-CPDP_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:59 INFO - Running setup.py (path:/tmp/pip-LbHu7V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:59 INFO - Running setup.py (path:/tmp/pip-CDCKp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:59 INFO - Running setup.py (path:/tmp/pip-zmgI1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:59 INFO - Running setup.py (path:/tmp/pip-lp3gqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:59 INFO - Running setup.py (path:/tmp/pip-4D0yIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:59 INFO - Running setup.py (path:/tmp/pip-0P2AWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:59 INFO - Running setup.py (path:/tmp/pip-WF9DVb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:59 INFO - Running setup.py (path:/tmp/pip-zIvaL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:00 INFO - Running setup.py install for manifestparser 09:23:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Running setup.py install for mozcrash 09:23:00 INFO - Running setup.py install for mozdebug 09:23:00 INFO - Running setup.py install for mozdevice 09:23:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Running setup.py install for mozfile 09:23:00 INFO - Running setup.py install for mozhttpd 09:23:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Running setup.py install for mozinfo 09:23:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Running setup.py install for mozInstall 09:23:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:23:00 INFO - Running setup.py install for mozleak 09:23:00 INFO - Running setup.py install for mozlog 09:23:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Running setup.py install for moznetwork 09:23:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Running setup.py install for mozprocess 09:23:01 INFO - Running setup.py install for mozprofile 09:23:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Running setup.py install for mozrunner 09:23:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Running setup.py install for mozscreenshot 09:23:01 INFO - Running setup.py install for moztest 09:23:01 INFO - Running setup.py install for mozversion 09:23:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:01 INFO - Cleaning up... 09:23:01 INFO - Return code: 0 09:23:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:01 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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:23:01 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 09:23:01 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 09:23:01 INFO - Using env: {'DISPLAY': ':0', 09:23:01 INFO - 'HOME': '/home/cltbld', 09:23:01 INFO - 'LANG': 'en_US.UTF-8', 09:23:01 INFO - 'LANGUAGE': 'en_US:en', 09:23:01 INFO - 'LOGNAME': 'cltbld', 09:23:01 INFO - 'MAIL': '/var/mail/cltbld', 09:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:01 INFO - 'MOZ_NO_REMOTE': '1', 09:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:01 INFO - 'NO_EM_RESTART': '1', 09:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:01 INFO - 'SHELL': '/bin/bash', 09:23:01 INFO - 'SHLVL': '1', 09:23:01 INFO - 'TERM': 'linux', 09:23:01 INFO - 'TMOUT': '86400', 09:23:01 INFO - 'USER': 'cltbld', 09:23:01 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:01 INFO - '_': '/tools/buildbot/bin/python'} 09:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:23:02 INFO - Running setup.py (path:/tmp/pip-vI9Q5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:23:02 INFO - Running setup.py (path:/tmp/pip-FtfQQY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:23:02 INFO - Running setup.py (path:/tmp/pip-OZsRIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:23:02 INFO - Running setup.py (path:/tmp/pip-qR1Vjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:23:02 INFO - Running setup.py (path:/tmp/pip-gGGWhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:23:02 INFO - Running setup.py (path:/tmp/pip-EU1tWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:23:02 INFO - Running setup.py (path:/tmp/pip-8xvUy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:23:02 INFO - Running setup.py (path:/tmp/pip-spWAyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:23:02 INFO - Running setup.py (path:/tmp/pip-Z5qQKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:23:02 INFO - Running setup.py (path:/tmp/pip-zchAJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:23:02 INFO - Running setup.py (path:/tmp/pip-xWuIJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:23:02 INFO - Running setup.py (path:/tmp/pip-5mlqBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:23:02 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:23:02 INFO - Running setup.py (path:/tmp/pip-XDHxsb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 09:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:23:02 INFO - Running setup.py (path:/tmp/pip-iAPp4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:23:03 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)) 09:23:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:23:03 INFO - Running setup.py (path:/tmp/pip-eYUMI3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:23:03 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)) 09:23:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:23:03 INFO - Running setup.py (path:/tmp/pip-iGL5iX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:23:03 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)) 09:23:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:03 INFO - Running setup.py (path:/tmp/pip-rB_sWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:03 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)) 09:23:03 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)) 09:23:03 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)) 09:23:03 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)) 09:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:03 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)) 09:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:04 INFO - Downloading blessings-1.5.1.tar.gz 09:23:04 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 09:23:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:04 INFO - Installing collected packages: blessings 09:23:04 INFO - Running setup.py install for blessings 09:23:05 INFO - Successfully installed blessings 09:23:05 INFO - Cleaning up... 09:23:05 INFO - Return code: 0 09:23:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:23:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:23:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:23:05 INFO - Reading from file tmpfile_stdout 09:23:05 INFO - Current package versions: 09:23:05 INFO - argparse == 1.2.1 09:23:05 INFO - blessings == 1.5.1 09:23:05 INFO - blobuploader == 1.2.4 09:23:05 INFO - docopt == 0.6.1 09:23:05 INFO - manifestparser == 1.1 09:23:05 INFO - mozInstall == 1.12 09:23:05 INFO - mozcrash == 0.16 09:23:05 INFO - mozdebug == 0.1 09:23:05 INFO - mozdevice == 0.47 09:23:05 INFO - mozfile == 1.2 09:23:05 INFO - mozhttpd == 0.7 09:23:05 INFO - mozinfo == 0.9 09:23:05 INFO - mozleak == 0.1 09:23:05 INFO - mozlog == 3.1 09:23:05 INFO - moznetwork == 0.27 09:23:05 INFO - mozprocess == 0.22 09:23:05 INFO - mozprofile == 0.27 09:23:05 INFO - mozrunner == 6.11 09:23:05 INFO - mozscreenshot == 0.1 09:23:05 INFO - mozsystemmonitor == 0.0 09:23:05 INFO - moztest == 0.7 09:23:05 INFO - mozversion == 1.4 09:23:05 INFO - psutil == 3.1.1 09:23:05 INFO - requests == 1.2.3 09:23:05 INFO - wsgiref == 0.1.2 09:23:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:23: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')]} 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:23:05 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 09:23:05 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 09:23:05 INFO - Using env: {'DISPLAY': ':0', 09:23:05 INFO - 'HOME': '/home/cltbld', 09:23:05 INFO - 'LANG': 'en_US.UTF-8', 09:23:05 INFO - 'LANGUAGE': 'en_US:en', 09:23:05 INFO - 'LOGNAME': 'cltbld', 09:23:05 INFO - 'MAIL': '/var/mail/cltbld', 09:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:05 INFO - 'MOZ_NO_REMOTE': '1', 09:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:05 INFO - 'NO_EM_RESTART': '1', 09:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:05 INFO - 'SHELL': '/bin/bash', 09:23:05 INFO - 'SHLVL': '1', 09:23:05 INFO - 'TERM': 'linux', 09:23:05 INFO - 'TMOUT': '86400', 09:23:05 INFO - 'USER': 'cltbld', 09:23:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:05 INFO - '_': '/tools/buildbot/bin/python'} 09:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:05 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 1)) 09:23:05 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 2)) 09:23:05 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 3)) 09:23:05 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 4)) 09:23:05 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 5)) 09:23:05 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 6)) 09:23:05 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 7)) 09:23:05 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 8)) 09:23:05 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:23:05 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 3)) 09:23:05 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:23:05 INFO - Cleaning up... 09:23:05 INFO - Return code: 0 09:23:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:23: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')]} 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:23:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:23:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:23:05 INFO - Using env: {'DISPLAY': ':0', 09:23:05 INFO - 'HOME': '/home/cltbld', 09:23:05 INFO - 'LANG': 'en_US.UTF-8', 09:23:05 INFO - 'LANGUAGE': 'en_US:en', 09:23:05 INFO - 'LOGNAME': 'cltbld', 09:23:05 INFO - 'MAIL': '/var/mail/cltbld', 09:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:05 INFO - 'MOZ_NO_REMOTE': '1', 09:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:05 INFO - 'NO_EM_RESTART': '1', 09:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:05 INFO - 'SHELL': '/bin/bash', 09:23:05 INFO - 'SHLVL': '1', 09:23:05 INFO - 'TERM': 'linux', 09:23:05 INFO - 'TMOUT': '86400', 09:23:05 INFO - 'USER': 'cltbld', 09:23:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:05 INFO - '_': '/tools/buildbot/bin/python'} 09:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:05 INFO - Downloading/unpacking jsonschema 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:07 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 09:23:07 INFO - Downloading/unpacking functools32 (from jsonschema) 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:23:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:07 INFO - warning: no files found matching '*.txt' 09:23:07 INFO - no previously-included directories found matching 'build' 09:23:07 INFO - no previously-included directories found matching 'dist' 09:23:07 INFO - no previously-included directories found matching '.git*' 09:23:07 INFO - Installing collected packages: jsonschema, functools32 09:23:07 INFO - Running setup.py install for functools32 09:23:07 INFO - warning: no files found matching '*.txt' 09:23:07 INFO - no previously-included directories found matching 'build' 09:23:07 INFO - no previously-included directories found matching 'dist' 09:23:07 INFO - no previously-included directories found matching '.git*' 09:23:07 INFO - Successfully installed jsonschema functools32 09:23:07 INFO - Cleaning up... 09:23:07 INFO - Return code: 0 09:23:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:23:07 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')]} 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:07 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')]} 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:07 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 0x7f1de5452f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', '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 09:23:07 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 09:23:07 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 09:23:07 INFO - Using env: {'DISPLAY': ':0', 09:23:07 INFO - 'HOME': '/home/cltbld', 09:23:07 INFO - 'LANG': 'en_US.UTF-8', 09:23:07 INFO - 'LANGUAGE': 'en_US:en', 09:23:07 INFO - 'LOGNAME': 'cltbld', 09:23:07 INFO - 'MAIL': '/var/mail/cltbld', 09:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:07 INFO - 'MOZ_NO_REMOTE': '1', 09:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:07 INFO - 'NO_EM_RESTART': '1', 09:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:07 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:07 INFO - 'SHELL': '/bin/bash', 09:23:07 INFO - 'SHLVL': '1', 09:23:07 INFO - 'TERM': 'linux', 09:23:07 INFO - 'TMOUT': '86400', 09:23:07 INFO - 'USER': 'cltbld', 09:23:07 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:07 INFO - '_': '/tools/buildbot/bin/python'} 09:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:08 INFO - Downloading/unpacking flake8 09:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:23:10 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 09:23:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:23:10 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 09:23:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:10 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 09:23:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:23:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:23:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:10 INFO - no previously-included directories found matching 'docs/_build' 09:23:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:23:10 INFO - Running setup.py install for pep8 09:23:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:10 INFO - no previously-included directories found matching 'docs/_build' 09:23:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:23:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:23:10 INFO - Cleaning up... 09:23:10 INFO - Return code: 0 09:23:10 INFO - Running post-action listener: _resource_record_post_action 09:23:10 INFO - Running post-action listener: _start_resource_monitoring 09:23:11 INFO - Starting resource monitoring. 09:23:11 INFO - ##### 09:23:11 INFO - ##### Running install step. 09:23:11 INFO - ##### 09:23:11 INFO - Running pre-action listener: _resource_record_pre_action 09:23:11 INFO - Running main action method: install 09:23:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:23:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:23:11 INFO - Reading from file tmpfile_stdout 09:23:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:23:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:23:11 INFO - Reading from file tmpfile_stdout 09:23:11 INFO - Output received: 09:23:11 INFO - Usage: mozinstall [options] installer 09:23:11 INFO - Options: 09:23:11 INFO - -h, --help show this help message and exit 09:23:11 INFO - -d DEST, --destination=DEST 09:23:11 INFO - Directory to install application into. [default: 09:23:11 INFO - "/builds/slave/test-pgo"] 09:23:11 INFO - --app=APP Application being installed. [default: firefox] 09:23:11 INFO - mkdir: /builds/slave/test-pgo/build/application 09:23:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:23:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:23:25 INFO - Reading from file tmpfile_stdout 09:23:25 INFO - Output received: 09:23:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:23:25 INFO - Running post-action listener: _resource_record_post_action 09:23:25 INFO - ##### 09:23:25 INFO - ##### Running run-tests step. 09:23:25 INFO - ##### 09:23:25 INFO - Running pre-action listener: _resource_record_pre_action 09:23:25 INFO - Running main action method: run_tests 09:23:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:23:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:23:25 INFO - Python 2.7.3 09:23:25 INFO - Return code: 0 09:23:25 INFO - grabbing minidump binary from tooltool 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b64a50>, '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 0x2ad0550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad09e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:23:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:23:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:23:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:25 INFO - Return code: 0 09:23:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:23:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:23:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:23:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:23:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:23:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:23:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:23:26 INFO - Return code: 0 09:23:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:23:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 09:23:26 INFO - Using env: {'DISPLAY': ':0', 09:23:26 INFO - 'HOME': '/home/cltbld', 09:23:26 INFO - 'LANG': 'en_US.UTF-8', 09:23:26 INFO - 'LANGUAGE': 'en_US:en', 09:23:26 INFO - 'LOGNAME': 'cltbld', 09:23:26 INFO - 'MAIL': '/var/mail/cltbld', 09:23:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:23:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:26 INFO - 'MOZ_NO_REMOTE': '1', 09:23:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:26 INFO - 'NO_EM_RESTART': '1', 09:23:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:23:26 INFO - 'SHELL': '/bin/bash', 09:23:26 INFO - 'SHLVL': '1', 09:23:26 INFO - 'TERM': 'linux', 09:23:26 INFO - 'TMOUT': '86400', 09:23:26 INFO - 'USER': 'cltbld', 09:23:26 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640', 09:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:26 INFO - '_': '/tools/buildbot/bin/python'} 09:23:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 09:23:27 INFO - mozversion INFO | application_buildid: 20151229070358 09:23:27 INFO - mozversion INFO | application_changeset: 0b0ad49b43179dcc416b81be4a08c5a8526977df 09:23:27 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:23:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:27 INFO - mozversion INFO | application_name: Firefox 09:23:27 INFO - mozversion INFO | application_remotingname: firefox-dev 09:23:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:23:27 INFO - mozversion INFO | application_vendor: Mozilla 09:23:27 INFO - mozversion INFO | application_version: 45.0a2 09:23:27 INFO - mozversion INFO | platform_buildid: 20151229070358 09:23:27 INFO - mozversion INFO | platform_changeset: 0b0ad49b43179dcc416b81be4a08c5a8526977df 09:23:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:23:27 INFO - mozversion INFO | platform_version: 45.0a2 09:23:27 INFO - 2015-12-29 09:23:27,073 DEBUG : using testdate: 1451409807 09:23:27 INFO - 2015-12-29 09:23:27,073 DEBUG : actual date: 1451409807 09:23:27 INFO - 2015-12-29 09:23:27,083 INFO : starting webserver on 'localhost:60863' 09:23:27 INFO - 2015-12-29 09:23:27,084 INFO : Starting test suite talos-linux64-ix-047.e 09:23:27 INFO - 2015-12-29 09:23:27,084 INFO : Starting test dromaeo_css 09:23:27 INFO - 2015-12-29 09:23:27,084 DEBUG : operating with platform_type : linux_ 09:23:27 INFO - 2015-12-29 09:23:27,084 INFO : Initialising browser for dromaeo_css test... 09:23:27 INFO - 2015-12-29 09:23:27,101 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp42tniS/profile http://localhost:60863/getInfo.html 09:23:31 INFO - 2015-12-29 09:23:31,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:23:31 INFO - 2015-12-29 09:23:31,222 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:23:31 INFO - 2015-12-29 09:23:31,223 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:23:31 INFO - 2015-12-29 09:23:31,223 DEBUG : BROWSER_OUTPUT: __metrics 09:23:32 INFO - 2015-12-29 09:23:32,397 INFO : Browser initialized. 09:23:32 INFO - 2015-12-29 09:23:32,398 INFO : Running cycle 1/1 for dromaeo_css test... 09:23:32 INFO - 2015-12-29 09:23:32,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp42tniS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:23:44 INFO - 2015-12-29 09:23:44,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 09:23:44 INFO - 2015-12-29 09:23:44,168 DEBUG : BROWSER_OUTPUT: 09:24:33 INFO - 2015-12-29 09:24:33,766 DEBUG : BROWSER_OUTPUT: 1451409873763 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] 09:26:41 INFO - 2015-12-29 09:26:41,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60863/tests/dromaeo/cssquery-ext.html) 09:26:42 INFO - 2015-12-29 09:26:42,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 141615104 09:26:42 INFO - 2015-12-29 09:26:42,671 DEBUG : BROWSER_OUTPUT: 09:29:44 INFO - 2015-12-29 09:29:44,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/dromaeo/cssquery-ext.html (next: http://localhost:60863/tests/dromaeo/cssquery-jquery.html) 09:29:44 INFO - 2015-12-29 09:29:44,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 141033472 09:29:44 INFO - 2015-12-29 09:29:44,900 DEBUG : BROWSER_OUTPUT: 09:32:46 INFO - 2015-12-29 09:32:46,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60863/tests/dromaeo/cssquery-mootools.html) 09:32:47 INFO - 2015-12-29 09:32:47,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 140218368 09:32:47 INFO - 2015-12-29 09:32:47,128 DEBUG : BROWSER_OUTPUT: 09:35:48 INFO - 2015-12-29 09:35:48,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60863/tests/dromaeo/cssquery-prototype.html) 09:35:49 INFO - 2015-12-29 09:35:49,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 140374016 09:35:49 INFO - 2015-12-29 09:35:49,262 DEBUG : BROWSER_OUTPUT: 09:38:51 INFO - 2015-12-29 09:38:51,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60863/tests/dromaeo/cssquery-yui.html) 09:38:52 INFO - 2015-12-29 09:38:52,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 140419072 09:38:52 INFO - 2015-12-29 09:38:52,060 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/dromaeo/cssquery-yui.html (next: http://localhost:60863/tests/dromaeo/cssquery-dojo.html) 09:41:54 INFO - 2015-12-29 09:41:54,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 142745600 09:41:54 INFO - 2015-12-29 09:41:54,462 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,462 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:41:54 INFO - 2015-12-29 09:41:54,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:41:54 INFO - 2015-12-29 09:41:54,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:41:54 INFO - 2015-12-29 09:41:54,462 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:41:54 INFO - 2015-12-29 09:41:54,462 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3365.713914317283;3377.273886114485;3401.2007178313092;3428.8457019434113;3440.8967730968066;5615.0173719599115;5669.659820410773;5690.260266165403;5696.25948626679;5711.657300561958;5663.461971112748;5696.401877802823;5722.914156287659;5723.885522289552;5730.226419433376;5201.0378080055125;5208.2968799212;5238.345206849144;5268.868278293055;5274;5064.265681476184;5126.512981266774;5129.717865517395;5165.664231824938;5264.184051472028;5149.871253218681;5222.164453687411;5226.451222621627;5228.032813929416;5228.843134705965;5161.9159976405;5197.636165468419;5270.1040823060175;5283.207518872162;5289.761960711778;4981.900361992776;5055.545000949895;5091.79632814687;5151.098557752416;5156.1750119980625;5489.423610520877;5510.421405752379;5537.667739935617;5572.052751032294;5574.470425309589;6114.327423983358;6137.693115344215;6177.289611694668;6188.845278868064;6191.9690401547705;6073.878522429527;6131.621347939075;6146.078088286748;6207.751689932397;6227.408396202353;5770.6249093808765;5779.422057794229;5784.4504772046585;5796.739146738365;5796.942030579682;6236.688165591702;6247.9062814057825;6260.24877014752;6272.655003974825;6299.842503937438;5820.272465941757;5992.250968628921;6028.849278768066;6091.725872335755;6156.353582873734;6069.969650151721;6088.4824789893355;6119.5104391648565;6151.661658608819;6161.44546990773;5980.073088671263;6067;6089.665068421191;6099.878002440015;6103.664298463627;6021.3677563856045;6058.27300723916;6099.054646529795;6136.171616831671;6137.294211165684;4687.507811679793;4696.835610753676;4699.882502937454;4707.576318131385;4736.834210802605;4118.691098167649;4191.685623578243;4228.957710422918;4236.809343579546;4279.828806847691;5788.0449725795615;5856.180134781134;5862.70686465675;5872.647641141545;5939.10913362999;6165.290991536031;6173.444390004921;6178.505719542426;6194.256689197326;6215.81352559424;5535.833924982257;5724.112762521816;5730.426957304237;5887.499562537232;5901.793437229762;5235.424103348629;5262.3158989331905;5272.393674727456;5281.894362112813;5288.391834938954;6327.96836015817;6348.269948955837;6354.936450635527;6355.745770169141;6390.233172019387;6112.908306375497;6141.508679305555;6147.569670123048;6181.99999999991;6215.875682486416;6102.7253773579405;6139.539534534839;6188.071789231652;6412.6152430852435;6429.292777794345;5953.851153721018;6001.7299221536005;6037.124616930609;6039.305479869696;6098.146259523582;5846.298444186725;6136.325004249618;6137.785177518944;6148.323684394623;6164.352742961924;5878.647281163144;5979.790707325223;5982.192404025401;5983;6010.789622363196;5948.613340132878;5988.490978266722;5989.221401217814;6026.548008899438;6061.545384096122;5724.398938111438;5848.883022339614;5914.58597898143;5931.9110213345975;5942.7920022799;6026.879462410815;6067.878642427038;6085.847853803691;6103.42017508336;6103.633781973096;5806.042003069446;5864.853378665397;5920.023196172756;5924.822255332347;5936.1095835625 09:41:54 INFO - 2015-12-29 09:41:54,466 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.498189084551;615.1295916278466;616.238944903045;620.5439002333284;653.6862306093078;31509.369812603763;32506.349873002524;39858.800705996466;40099.59900400995;40367;44972.77513612428;45453;45477.31784023243;45522.317165242544;45681.31478027832;9142.542872856364;9268.907310926872;9301.627934882597;9323.160915517603;9335.813283734322;8966.686165984192;9075.410098343587;9081.682141125062;9095.499747513884;9102.63589456421;9073.455592664428;9199.080091990782;9202.815943681122;9204.907950920471;9231.723048308562;9117.817643647157;9123.406978546407;9160.72517824463;9176.03651616584;9193.999999999967;9018.639254429814;9166.312526560534;9170.770730731785;9171;9200.539973001323;41976.58023419788;42381;42640;42645.786771066254;42661.786691066656;3460.653934606544;3491.3513782961863;3549.3078849624335;3578.556532732092;3587.031501494608;31573;32182.356352872812;32234.516482252784;32257;32731.18172045694;4025.215083058805;4096.713230073896;4170.145120250341;4187.183499217654;4218.029853133797;286857;286975;288131.9999999979;288702;289411;44219.557804422184;44742.77628611836;44981.55018449839;45008.32487512624;61678.383216168164;43799.56200437955;43888.561114389086;43896.024678889524;43974;43989.560104398544;16562;16877.07176105326;16956.74564881528;17008.31966721342;17061.232244549024;13636.113652612548;13873.722525549634;13879.4448222072;13898;13966.511172108927;15218.847811521964;15237.238138093273;15238.238088095552;15322.080675159303;15342.463013794464;6126.203593532812;6261.8747625047245;6294.559380843389;6334.144890439732;6366.395192456709;1006.7533454303742;1114.164376717462;1120.4230717518865;1138.1463902073444;1157.2246594781516;33534.49698254528;33695.4945675815;34298;34440.82779586136;34606.480902786476;1075.9031687148195;1081.588996181446;1085.847981282621;1150.9597164099216;1173.9941300293444;15205.239738013055;15290.388384464497;15466.952632023074;15595.922020389826;15806.9209653951;443058;624472;739579;750039;756141;57139.428605714245;58020;58588.12117818236;58711.412885870595;58762.41237587655;1488.5013520470764;1504.3907217576898;1517.5068102866612;1518.0663891706522;1524.885633577486;30222.244443888198;31228;31326.530102048033;31454.52818207683;31839.36321273608;49815.50184498109;49909;50297.24554131618;50448.24327635162;50452.24321635105;331882;331977;333588;335196;335925;34310.31379372448;34885;34999;35085;35284;45632.77183614193;46077;46482.07035859196;46788;47162;38651;38883.61116388913;39872.601273988046;39895.2020959585;40473.98815029648;39040;39384.6061539381;39412.40881386839;39653.60346396499;39958.800205998785;38253.42619860649;38410.231795364496;38647;38690.6130938687;38813.223735525695;34605.48091778575;34614.82692586521;35116.473252900716;35225.823870881504;35287.82356088203;26172.214833555023;26319.21042368732;26461;26658;27180.456390872467 09:41:54 INFO - 2015-12-29 09:41:54,466 DEBUG : BROWSER_OUTPUT: |2;jquery.html;391.2039000633711;394.07196053294484;397.25514660012476;397.7851959941632;400.4673783867456;15879.603009924758;16663.50009499714;17389.56526086847;19725.112369943352;19798.505037374074;11762.176647634647;12229.571964981227;12299.569515066974;12433.440495177716;12472.625821225378;5252.947470525303;5264.263003179539;5366.812161574346;5367.436419175989;5371.81198658047;5204.531592156705;5317.803494213809;5443.972780136094;5515.062439385294;5530.087535556649;5463.972680136594;5473.698946557938;5496.862578435531;5562.221289019541;5804.9419505805035;5752.165935939307;5761.740721667514;5786.132080187964;5797.36229014808;5804.158397032449;5419.295491586068;5468.207109969072;5493.395726470085;5577.637453565505;5580.302462192226;13389.732205355838;13467.124636898669;13590.116642418212;18558.90720546402;21494.677579836316;2283.8743869087193;2294.9311520654405;2306.3081075677396;2306.4810417656063;2341.555104530134;10045.89954100457;10370.948145259226;10393.79212415755;11934.582289619822;14381;1936.893470859102;1996.2214736252872;1999.990000050005;2023.7773844877051;2040.1533363654066;64308.356916430705;66760.33239667541;67554.66222668905;68610.3138968614;69513.65243173802;10357.378557286587;10374.688759337232;10383.792324153626;10560;10720.731981700364;13266.204027758366;13316.600501984956;13326.466941322433;13353.73292534144;13357.799633005512;8160.143184965612;8263.214994575506;8291.626876790559;8306.08633050364;8378.371622128243;8393.664253429795;8393.790155246168;8401.915980840113;8425.957870210732;8431.325493960469;4078.1232035112594;4261.105167914772;4311.784410779448;4315.633171180485;4487.910241795146;1815.110595808071;1855.4340926017694;1861.944141675752;1888.4429093417475;1948.581055073166;487.14506041896954;950.9286803489628;1040.812653722322;1054.8786889507805;1095.6658219243207;11050.778984420267;11212.719682008015;11235.94382028101;11405.657830265105;11429.942850285861;479.08494774979624;492.6576029659352;494.4141192686678;497.6044044984246;502.0661569480763;6199.876002480015;6299.370062993664;6300.401461861115;6338.271098823602;6380.808575742735;651102;654971;657941;672349;681462;84574;86297.56851215704;86644.56677716572;87896;88052.11947880567;1186.602488166474;1193.5643490126042;1199.898008669273;1200.0699457920007;1200.7778560966249;16506.83493165053;16622.750658739886;16635.085070320765;16663.833361666228;17039.744403833705;37384.439233412064;37502.249955001294;37504;38680.41979370255;38996.805015974736;51450;51679.74160129175;51797;52256.21615675692;54534.727326363114;10069.395836249849;10075.647352342927;10333.379997200193;10400.27198096126;10417.166626669698;12192;14052.437902483785;16344;17850.642987140443;17917.104144792447;14705;14900.552983410515;15035.849641503444;15408.768868466757;15527.146006969726;14718.55844324672;15220.847791521943;15338.233088345314;15666.138362390178;16039.438619648723;15381.538553843402;15744.68510629758;15791.842081579496;15849.920750396173;16075.839241607435;10383.740406489898;10446.529906154394;10546.630867919894;10609.257351985287;10650.307729997525;10977.3962432067;11040.779184416428;14331.856681433052;15808.92095539515;15947.043177409392 09:41:54 INFO - 2015-12-29 09:41:54,469 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1460.8539146085393;1473.3369983507419;1666.8583170430513;1797.1014492753623;1836.9712960741986;7893.565853878034;8068.838623227532;8127.065387480441;8270.462419942707;8273.50358978461;8261.173882611736;8282.33741300696;8410.537420441873;8415.452995555284;8422.28410585101;2364.8226383021256;2392.258399896029;2397.3646983549374;2414.6015907375263;2418.3470462974988;2336.649502574619;2382.690250267463;2383.940401489959;2401.0635852017726;2406.651035599837;2280.053777682268;2293.885305734715;2328.208409140892;2371.3123194273726;2400.59189937711;2304.6312589985523;2319.2694301295037;2342.7422983471806;2345.812335013195;2347.5891718949115;2279.566882292376;2318.8724620145886;2328.662343960133;2334.8015418689433;2342.5666251743482;7939.166387529284;7972.724364101774;7983.920160798376;7997.560134192617;8027.598620068973;4793.18515852306;4887.755612219375;4916.139675556799;4917.680350777224;4948.282499037619;3220.533022711694;3249.23642943908;3284.0312107928216;3325.3681800457834;3325.90022299329;1031.6698656429946;1044.3107549017611;1062.5324857062867;1094.496531595467;1101.091599430473;10968.945155274252;11003.669889903316;11007.834882476769;11012.17408694351;11031.61389351377;4359.564043595615;4407.955920440754;4428.601425871622;4464.06254686513;4466.419365482467;9024.097590240923;9046.728598142066;9048.819023619491;9049.321300902458;9101.726948191565;4971.825986090469;4990.5508504234795;5002.649814512949;5008.273800298936;5026.29631851541;4565.086982603492;4580.564846339593;4591.449026116888;4609.907801843944;4612.838550650711;3632.8728494503093;3684.9447258291148;3717.683996860243;3725.2549490102087;3737.4206997915367;1103.5199688135688;1117.6702872652425;1128.700894263021;1129.3280498103616;1143.2854465958776;1018.5721996761378;1021.5352014833232;1136.4942600542845;1312.1077667186214;1433.0756661952983;7558.735444259424;7580.658870350848;7634.274743899321;7634.351080158138;7698.461107722405;676.8815457294953;682.5461068389565;690.6132565763189;697.3026973026973;834.1616675241344;5809.68046757424;5839.270091238595;5839.766409343579;5853.268341457318;5856.0630299151935;9276.072392760805;9461.148496635336;9640;9747.366421182742;9837.950810245902;9546.284028697875;9590.952045239868;9662.13040826329;9671.516424178762;9737.513124343754;7345.449091318173;7399.963000184965;7625.542467451971;7651;7674.923250767532;7413.925860741324;7417.592032438268;7436.4050875928715;7459.477836551607;7466.216047315171;8391.748247552583;8564.186402291773;8625.784355391166;8651.221390074923;8690.34822388336;8742;8834.028256891865;8846.557672116498;8863.734087977371;8866.911330886609;6934.479914006571;6958.582485050913;6965.059716938148;6980.7207711693;6995.370416662525;7903.604819758874;7909.7231596893835;7913.643886025027;7936.722214722457;7946.086200087064;7076.752313668997;7284.125904891447;7309;7335;7477.102747670315;7010.929890701028;7087;7247.2390399007345;7257.52826066304;7350.338469537767;7037.542559733601;7072.893906591303;7111.146662400545;7114.430845532448;7127.786166415016;6817.420519255918;6852.897206542006;6879.552829066095;6881.41507971828;6904.240533541407;6421.71102300407;6629.270780214269;6668.166479190101;6700.396964273239;6732.394084532416 09:41:54 INFO - 2015-12-29 09:41:54,469 DEBUG : BROWSER_OUTPUT: |4;prototype.html;366.44666553504203;369.82618169460346;371.9349113905066;374.2160174434559;376.19306587370085;6220.440160385564;6307.716152773125;6314.336994615563;6356.332585078564;6463.967680161599;6163.013917773157;6300.275468321144;6306.05409188622;6319.052142178675;6322.399372059647;4900.730459824708;4905.828296009631;4914.164592019365;4914.97542512287;4936.580390666798;4915.041566894439;4933.062718083571;4935.629827762914;4936.481669424713;4954.578860796837;4685.109829132454;4801;4805.063012712522;4813.735244561548;4813.831515896944;4790.736509491977;4792.904141917177;4808.927866082012;4818.566329030404;4848.418189817209;4209.74741515507;4233.830646774125;4246.214450326699;4249.213895429355;4254;5945.583809133363;5969.074793407029;6039.4262545058145;6046.909296360558;6067.150598916155;5636.830895073113;5669.376368599451;5674.404187560329;5686.317641882959;5688.345840228385;6686.699098540577;6714.83212919676;6727.428168605675;6728.259891411941;6730.697118629624;4657.976710116462;4675.696079754805;4686.601638860701;4695.929561056552;4727.456342520585;6911.3779759821855;6971.372576468142;6997.405220556258;7045.894311585279;7048.365647091787;4805.807767689324;4809.927851082237;4810.6632535722865;4818.855434336975;4819.831305904277;4872.610191184696;4885.316055752198;4886.120498310338;4888.951110488921;4890.584300334512;5551.7779288828;5639.182318563785;5644.379118296984;5645.4072322405555;5645.689487078168;6765.560238584476;6815.114035175396;6819.863602727918;6823.147106611674;6844.247132815386;1688.5103320037297;1724.3619860651388;1724.8965062096315;1727.7408388741537;1729.5935455168026;1152.976940461203;1166.4925757295434;1175.341808587194;1176.211938001524;1181.3856794466828;6501.869962600722;6576.704048317837;6587.077809106729;6596;6597.538172327891;6941.930580694128;6945.236024037352;6953.33943275388;6958.443324534025;6970.302969702989;6457.160569125984;6575.145231119924;6581;6592.241892182365;6594.175728033996;3732.7760334380023;3761.2665530221343;3771.773693578394;3780.4140358243967;3788;7139.464540159509;7145.21402645719;7157.2127066022695;7160.462965277521;7168.139823221247;7064.50548461613;7094.751683691046;7134.571925684476;7151.964240178766;7324.974503569504;7213.1704853942465;7317.341439270384;7320.231375705474;7325;7328.743493977685;7089.184743754328;7109.431245500451;7117.1459424869345;7124.964375178091;7134.250903655042;6886.758963436256;6945.548539344926;6987.196472405739;7000.229974702676;7005.369516743517;7239.095113110861;7299.233580474186;7302.96348518254;7309.817254568678;7314.122305323395;4742.928856067093;4804.639652026042;4807.182778927521;4812.422509298906;4820.855374338776;6955.513114081966;6958.165020197406;7032.5077244592385;7061.752838650623;7142.142942846892;6917.827054323682;6935.687894044881;6940.826479338057;6955.965220174069;6967.895481567679;6905.792826215222;6929.7228110875;6936.7225310987;6937.098177237129;6937.445004399737;6647.867042659023;6736.797896063126;6797.728090876507;6804.897926531205;6814.897776533257;6920.653967301715;6950.687219075053;6953.096097507291;6966.12923384577;6975.581465112109;6710.745110460006;6788.456923446014;6794.456443484411;6796.150481189851;6808.217055038536 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: |5;yui.html;844.5355054719904;893.9865902011471;903.6746771162381;907.4918045894295;956.4500412262948;13932.373043213054;14133.152010879354;14535.127892326467;14545.909056820741;14551.708965820677;14583.197924114169;14702.411903523873;14723.999999999973;14751.77872331916;14755.26223688814;741.9406447484188;744.4342299852125;901.6168128545359;916.408916249019;918.5636822509322;903.661127077346;904.8687940248693;905.0496978172893;912.8493798523235;913.6162811619135;961.4808003678005;967.3277072434661;967.569431602937;969.4328817641688;973.4597298499366;958.6021800952597;963.0802583532779;963.5375019990408;963.6097380560849;967.2068903499134;699.3356311504092;708.8617719544691;711.8433944532195;712.1560950273941;713.0338391479575;13394.928405727518;13507.932460337635;13510.932445337809;13544.187348759106;13546.45814167432;13036.543720969721;13042.934785326108;13418;13433.66415839602;13534;11126.721831954184;11314.264572802742;11372.886271137348;11419.25774824642;11485.310881347146;3843.4619153318276;3877;3906.8437262509465;3910.1397692507603;3911.2177564487215;47317;47851.99999999965;47896.760516197544;48832.26751598729;49100.75449622729;10357.585696572052;10361.326513776581;10377.688669339932;10534.841977370346;10899.673009809718;18887;19482.80517194838;19529.218831246875;19650.803491965184;19781.208751649774;7919.6832126715435;8003.439759216915;8060.516369017878;8135.227153420416;8309.95845020771;4738.099761045391;4781.876259079114;4864.343313652683;4964.478729733326;4965.3048573199785;3353.748468864845;3366.882159124419;3382.458806590934;3385.3398587275738;3385.509101180315;609.9664518451439;623.2925629410652;625.293418437163;627.6516533323958;641.3522342434175;738.9567844908831;739.2311995524701;747.689708770854;762.1616222155584;774.71722821171;9245.260379169651;9632.855507167398;9700.078492543196;9705.757356066155;9804.754881128029;684.2985939412142;731.3016069653468;736.752903643884;738.2027410396759;755.6737924941692;4246.214450326699;4589.609883159902;4606.216943119678;4632.305154226893;4679.883002924886;60121.398786012454;60302;60771;64142.67928660327;64312.35687643157;53348.73325633347;53825.730871346175;54592.45407545953;54854.725726371114;55145.44854551483;49278.26082608764;49456;49459.75270123626;49823.99999999927;50413.74793126084;9658.034196580285;9696.612135514782;9841.85237221428;9846.777156589189;9890.14824750805;35414.82292588521;36207.094822629646;37037.25925481529;37422.625773741915;37630.247395051396;46414.535854642374;47450.28824567565;47540.52459475499;47684;48819.5118048815;10939.671809845717;11096.889031109586;11120.499577519193;11905.761884762429;11964.820527691918;13322.866771332163;13619.38712757948;13680.589582312547;13867.167969921837;14411.063280886709;11715.121365897763;11801.168077845585;11897.40512974365;11967.461464234304;12030.518779249081;12421.37893105323;12880;12905;13136.671583210114;13189.472421103048;11873.643790686294;12030.578929737418;12062.155649104478;12163.45264463119;12383.133180677267;9922.801543969224;10182.592696292066;10204.948975255076;10438.791224175322;10717.464126793786;9627.133557979816;10295.279330447096;10306.793864122825;10341.896581034394;10361.378317300987 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: __startTimestamp1451410914460__endTimestamp 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,471 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5684.74 Median:5920.02 stddev:636.71 (10.8%) stddev-sans-first:612.12 09:41:54 INFO - 2015-12-29 09:41:54,472 DEBUG : BROWSER_OUTPUT: Values: 3365.7 3377.3 3401.2 3428.8 3440.9 5615.0 5669.7 5690.3 5696.3 5711.7 5663.5 5696.4 5722.9 5723.9 5730.2 5201.0 5208.3 5238.3 5268.9 5274.0 5064.3 5126.5 5129.7 5165.7 5264.2 5149.9 5222.2 5226.5 5228.0 5228.8 5161.9 5197.6 5270.1 5283.2 5289.8 4981.9 5055.5 5091.8 5151.1 5156.2 5489.4 5510.4 5537.7 5572.1 5574.5 6114.3 6137.7 6177.3 6188.8 6192.0 6073.9 6131.6 6146.1 6207.8 6227.4 5770.6 5779.4 5784.5 5796.7 5796.9 6236.7 6247.9 6260.2 6272.7 6299.8 5820.3 5992.3 6028.8 6091.7 6156.4 6070.0 6088.5 6119.5 6151.7 6161.4 5980.1 6067.0 6089.7 6099.9 6103.7 6021.4 6058.3 6099.1 6136.2 6137.3 4687.5 4696.8 4699.9 4707.6 4736.8 4118.7 4191.7 4229.0 4236.8 4279.8 5788.0 5856.2 5862.7 5872.6 5939.1 6165.3 6173.4 6178.5 6194.3 6215.8 5535.8 5724.1 5730.4 5887.5 5901.8 5235.4 5262.3 5272.4 5281.9 5288.4 6328.0 6348.3 6354.9 6355.7 6390.2 6112.9 6141.5 6147.6 6182.0 6215.9 6102.7 6139.5 6188.1 6412.6 6429.3 5953.9 6001.7 6037.1 6039.3 6098.1 5846.3 6136.3 6137.8 6148.3 6164.4 5878.6 5979.8 5982.2 5983.0 6010.8 5948.6 5988.5 5989.2 6026.5 6061.5 5724.4 5848.9 5914.6 5931.9 5942.8 6026.9 6067.9 6085.8 6103.4 6103.6 5806.0 5864.9 5920.0 5924.8 5936.1 09:41:54 INFO - 2015-12-29 09:41:54,472 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,472 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:58144.74 Median:39398.51 stddev:124633.49 (316.3%) stddev-sans-first:124908.16 09:41:54 INFO - 2015-12-29 09:41:54,473 DEBUG : BROWSER_OUTPUT: Values: 573.5 615.1 616.2 620.5 653.7 31509.4 32506.3 39858.8 40099.6 40367.0 44972.8 45453.0 45477.3 45522.3 45681.3 9142.5 9268.9 9301.6 9323.2 9335.8 8966.7 9075.4 9081.7 9095.5 9102.6 9073.5 9199.1 9202.8 9204.9 9231.7 9117.8 9123.4 9160.7 9176.0 9194.0 9018.6 9166.3 9170.8 9171.0 9200.5 41976.6 42381.0 42640.0 42645.8 42661.8 3460.7 3491.4 3549.3 3578.6 3587.0 31573.0 32182.4 32234.5 32257.0 32731.2 4025.2 4096.7 4170.1 4187.2 4218.0 286857.0 286975.0 288132.0 288702.0 289411.0 44219.6 44742.8 44981.6 45008.3 61678.4 43799.6 43888.6 43896.0 43974.0 43989.6 16562.0 16877.1 16956.7 17008.3 17061.2 13636.1 13873.7 13879.4 13898.0 13966.5 15218.8 15237.2 15238.2 15322.1 15342.5 6126.2 6261.9 6294.6 6334.1 6366.4 1006.8 1114.2 1120.4 1138.1 1157.2 33534.5 33695.5 34298.0 34440.8 34606.5 1075.9 1081.6 1085.8 1151.0 1174.0 15205.2 15290.4 15467.0 15595.9 15806.9 443058.0 624472.0 739579.0 750039.0 756141.0 57139.4 58020.0 58588.1 58711.4 58762.4 1488.5 1504.4 1517.5 1518.1 1524.9 30222.2 31228.0 31326.5 31454.5 31839.4 49815.5 49909.0 50297.2 50448.2 50452.2 331882.0 331977.0 333588.0 335196.0 335925.0 34310.3 34885.0 34999.0 35085.0 35284.0 45632.8 46077.0 46482.1 46788.0 47162.0 38651.0 38883.6 39872.6 39895.2 40474.0 39040.0 39384.6 39412.4 39653.6 39958.8 38253.4 38410.2 38647.0 38690.6 38813.2 34605.5 34614.8 35116.5 35225.8 35287.8 26172.2 26319.2 26461.0 26658.0 27180.5 09:41:54 INFO - 2015-12-29 09:41:54,473 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,473 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32716.53 Median:2031.97 stddev:108502.47 (5339.8%) stddev-sans-first:108779.70 09:41:54 INFO - 2015-12-29 09:41:54,473 DEBUG : BROWSER_OUTPUT: Values: 391.2 394.1 397.3 397.8 400.5 15879.6 16663.5 17389.6 19725.1 19798.5 11762.2 12229.6 12299.6 12433.4 12472.6 5252.9 5264.3 5366.8 5367.4 5371.8 5204.5 5317.8 5444.0 5515.1 5530.1 5464.0 5473.7 5496.9 5562.2 5804.9 5752.2 5761.7 5786.1 5797.4 5804.2 5419.3 5468.2 5493.4 5577.6 5580.3 13389.7 13467.1 13590.1 18558.9 21494.7 2283.9 2294.9 2306.3 2306.5 2341.6 10045.9 10370.9 10393.8 11934.6 14381.0 1936.9 1996.2 2000.0 2023.8 2040.2 64308.4 66760.3 67554.7 68610.3 69513.7 10357.4 10374.7 10383.8 10560.0 10720.7 13266.2 13316.6 13326.5 13353.7 13357.8 8160.1 8263.2 8291.6 8306.1 8378.4 8393.7 8393.8 8401.9 8426.0 8431.3 4078.1 4261.1 4311.8 4315.6 4487.9 1815.1 1855.4 1861.9 1888.4 1948.6 487.1 950.9 1040.8 1054.9 1095.7 11050.8 11212.7 11235.9 11405.7 11429.9 479.1 492.7 494.4 497.6 502.1 6199.9 6299.4 6300.4 6338.3 6380.8 651102.0 654971.0 657941.0 672349.0 681462.0 84574.0 86297.6 86644.6 87896.0 88052.1 1186.6 1193.6 1199.9 1200.1 1200.8 16506.8 16622.8 16635.1 16663.8 17039.7 37384.4 37502.2 37504.0 38680.4 38996.8 51450.0 51679.7 51797.0 52256.2 54534.7 10069.4 10075.6 10333.4 10400.3 10417.2 12192.0 14052.4 16344.0 17850.6 17917.1 14705.0 14900.6 15035.8 15408.8 15527.1 14718.6 15220.8 15338.2 15666.1 16039.4 15381.5 15744.7 15791.8 15849.9 16075.8 10383.7 10446.5 10546.6 10609.3 10650.3 10977.4 11040.8 14331.9 15808.9 15947.0 09:41:54 INFO - 2015-12-29 09:41:54,474 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,474 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5638.32 Median:3747.15 stddev:2923.43 (78.0%) stddev-sans-first:2914.77 09:41:54 INFO - 2015-12-29 09:41:54,475 DEBUG : BROWSER_OUTPUT: Values: 1460.9 1473.3 1666.9 1797.1 1837.0 7893.6 8068.8 8127.1 8270.5 8273.5 8261.2 8282.3 8410.5 8415.5 8422.3 2364.8 2392.3 2397.4 2414.6 2418.3 2336.6 2382.7 2383.9 2401.1 2406.7 2280.1 2293.9 2328.2 2371.3 2400.6 2304.6 2319.3 2342.7 2345.8 2347.6 2279.6 2318.9 2328.7 2334.8 2342.6 7939.2 7972.7 7983.9 7997.6 8027.6 4793.2 4887.8 4916.1 4917.7 4948.3 3220.5 3249.2 3284.0 3325.4 3325.9 1031.7 1044.3 1062.5 1094.5 1101.1 10968.9 11003.7 11007.8 11012.2 11031.6 4359.6 4408.0 4428.6 4464.1 4466.4 9024.1 9046.7 9048.8 9049.3 9101.7 4971.8 4990.6 5002.6 5008.3 5026.3 4565.1 4580.6 4591.4 4609.9 4612.8 3632.9 3684.9 3717.7 3725.3 3737.4 1103.5 1117.7 1128.7 1129.3 1143.3 1018.6 1021.5 1136.5 1312.1 1433.1 7558.7 7580.7 7634.3 7634.4 7698.5 676.9 682.5 690.6 697.3 834.2 5809.7 5839.3 5839.8 5853.3 5856.1 9276.1 9461.1 9640.0 9747.4 9838.0 9546.3 9591.0 9662.1 9671.5 9737.5 7345.4 7400.0 7625.5 7651.0 7674.9 7413.9 7417.6 7436.4 7459.5 7466.2 8391.7 8564.2 8625.8 8651.2 8690.3 8742.0 8834.0 8846.6 8863.7 8866.9 6934.5 6958.6 6965.1 6980.7 6995.4 7903.6 7909.7 7913.6 7936.7 7946.1 7076.8 7284.1 7309.0 7335.0 7477.1 7010.9 7087.0 7247.2 7257.5 7350.3 7037.5 7072.9 7111.1 7114.4 7127.8 6817.4 6852.9 6879.6 6881.4 6904.2 6421.7 6629.3 6668.2 6700.4 6732.4 09:41:54 INFO - 2015-12-29 09:41:54,475 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,475 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5689.19 Median:6482.92 stddev:1723.01 (26.6%) stddev-sans-first:1680.89 09:41:54 INFO - 2015-12-29 09:41:54,475 DEBUG : BROWSER_OUTPUT: Values: 366.4 369.8 371.9 374.2 376.2 6220.4 6307.7 6314.3 6356.3 6464.0 6163.0 6300.3 6306.1 6319.1 6322.4 4900.7 4905.8 4914.2 4915.0 4936.6 4915.0 4933.1 4935.6 4936.5 4954.6 4685.1 4801.0 4805.1 4813.7 4813.8 4790.7 4792.9 4808.9 4818.6 4848.4 4209.7 4233.8 4246.2 4249.2 4254.0 5945.6 5969.1 6039.4 6046.9 6067.2 5636.8 5669.4 5674.4 5686.3 5688.3 6686.7 6714.8 6727.4 6728.3 6730.7 4658.0 4675.7 4686.6 4695.9 4727.5 6911.4 6971.4 6997.4 7045.9 7048.4 4805.8 4809.9 4810.7 4818.9 4819.8 4872.6 4885.3 4886.1 4889.0 4890.6 5551.8 5639.2 5644.4 5645.4 5645.7 6765.6 6815.1 6819.9 6823.1 6844.2 1688.5 1724.4 1724.9 1727.7 1729.6 1153.0 1166.5 1175.3 1176.2 1181.4 6501.9 6576.7 6587.1 6596.0 6597.5 6941.9 6945.2 6953.3 6958.4 6970.3 6457.2 6575.1 6581.0 6592.2 6594.2 3732.8 3761.3 3771.8 3780.4 3788.0 7139.5 7145.2 7157.2 7160.5 7168.1 7064.5 7094.8 7134.6 7152.0 7325.0 7213.2 7317.3 7320.2 7325.0 7328.7 7089.2 7109.4 7117.1 7125.0 7134.3 6886.8 6945.5 6987.2 7000.2 7005.4 7239.1 7299.2 7303.0 7309.8 7314.1 4742.9 4804.6 4807.2 4812.4 4820.9 6955.5 6958.2 7032.5 7061.8 7142.1 6917.8 6935.7 6940.8 6956.0 6967.9 6905.8 6929.7 6936.7 6937.1 6937.4 6647.9 6736.8 6797.7 6804.9 6814.9 6920.7 6950.7 6953.1 6966.1 6975.6 6710.7 6788.5 6794.5 6796.2 6808.2 09:41:54 INFO - 2015-12-29 09:41:54,475 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-12-29 09:41:54,475 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14715.92 Median:26094.19 stddev:16812.96 (64.4%) stddev-sans-first:16827.86 09:41:54 INFO - 2015-12-29 09:41:54,477 DEBUG : BROWSER_OUTPUT: Values: 844.5 894.0 903.7 907.5 956.5 13932.4 14133.2 14535.1 14545.9 14551.7 14583.2 14702.4 14724.0 14751.8 14755.3 741.9 744.4 901.6 916.4 918.6 903.7 904.9 905.0 912.8 913.6 961.5 967.3 967.6 969.4 973.5 958.6 963.1 963.5 963.6 967.2 699.3 708.9 711.8 712.2 713.0 13394.9 13507.9 13510.9 13544.2 13546.5 13036.5 13042.9 13418.0 13433.7 13534.0 11126.7 11314.3 11372.9 11419.3 11485.3 3843.5 3877.0 3906.8 3910.1 3911.2 47317.0 47852.0 47896.8 48832.3 49100.8 10357.6 10361.3 10377.7 10534.8 10899.7 18887.0 19482.8 19529.2 19650.8 19781.2 7919.7 8003.4 8060.5 8135.2 8310.0 4738.1 4781.9 4864.3 4964.5 4965.3 3353.7 3366.9 3382.5 3385.3 3385.5 610.0 623.3 625.3 627.7 641.4 739.0 739.2 747.7 762.2 774.7 9245.3 9632.9 9700.1 9705.8 9804.8 684.3 731.3 736.8 738.2 755.7 4246.2 4589.6 4606.2 4632.3 4679.9 60121.4 60302.0 60771.0 64142.7 64312.4 53348.7 53825.7 54592.5 54854.7 55145.4 49278.3 49456.0 49459.8 49824.0 50413.7 9658.0 9696.6 9841.9 9846.8 9890.1 35414.8 36207.1 37037.3 37422.6 37630.2 46414.5 47450.3 47540.5 47684.0 48819.5 10939.7 11096.9 11120.5 11905.8 11964.8 13322.9 13619.4 13680.6 13867.2 14411.1 11715.1 11801.2 11897.4 11967.5 12030.5 12421.4 12880.0 12905.0 13136.7 13189.5 11873.6 12030.6 12062.2 12163.5 12383.1 9922.8 10182.6 10204.9 10438.8 10717.5 9627.1 10295.3 10306.8 10341.9 10361.4 09:41:54 INFO - 2015-12-29 09:41:54,477 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:41:54 INFO - 2015-12-29 09:41:54,477 DEBUG : BROWSER_OUTPUT: 09:41:55 INFO - 2015-12-29 09:41:55,053 INFO : Browser exited with error code: 0 09:41:55 INFO - 2015-12-29 09:41:55,077 INFO : Completed test dromaeo_css (00:18:27) 09:41:55 INFO - 2015-12-29 09:41:55,077 INFO : Starting test kraken 09:41:55 INFO - 2015-12-29 09:41:55,077 DEBUG : operating with platform_type : linux_ 09:41:55 INFO - 2015-12-29 09:41:55,077 INFO : Initialising browser for kraken test... 09:41:55 INFO - 2015-12-29 09:41:55,083 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoT6T91/profile http://localhost:60863/getInfo.html 09:41:59 INFO - 2015-12-29 09:41:59,243 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:41:59 INFO - 2015-12-29 09:41:59,243 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:41:59 INFO - 2015-12-29 09:41:59,243 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:41:59 INFO - 2015-12-29 09:41:59,243 DEBUG : BROWSER_OUTPUT: __metrics 09:42:00 INFO - 2015-12-29 09:42:00,141 INFO : Browser initialized. 09:42:00 INFO - 2015-12-29 09:42:00,142 INFO : Running cycle 1/1 for kraken test... 09:42:00 INFO - 2015-12-29 09:42:00,142 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoT6T91/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:42:11 INFO - 2015-12-29 09:42:11,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 138375168 09:42:11 INFO - 2015-12-29 09:42:11,921 DEBUG : BROWSER_OUTPUT: 09:42:14 INFO - 2015-12-29 09:42:14,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60863/tests/kraken/driver.html?testName=audio-beat-detection) 09:42:14 INFO - 2015-12-29 09:42:14,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 138293248 09:42:14 INFO - 2015-12-29 09:42:14,999 DEBUG : BROWSER_OUTPUT: 09:42:17 INFO - 2015-12-29 09:42:17,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60863/tests/kraken/driver.html?testName=audio-dft) 09:42:18 INFO - 2015-12-29 09:42:18,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 138186752 09:42:18 INFO - 2015-12-29 09:42:18,194 DEBUG : BROWSER_OUTPUT: 09:42:21 INFO - 2015-12-29 09:42:21,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60863/tests/kraken/driver.html?testName=audio-fft) 09:42:21 INFO - 2015-12-29 09:42:21,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 138047488 09:42:21 INFO - 2015-12-29 09:42:21,601 DEBUG : BROWSER_OUTPUT: 09:42:23 INFO - 2015-12-29 09:42:23,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60863/tests/kraken/driver.html?testName=audio-oscillator) 09:42:24 INFO - 2015-12-29 09:42:24,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 139554816 09:42:24 INFO - 2015-12-29 09:42:24,215 DEBUG : BROWSER_OUTPUT: 09:42:26 INFO - 2015-12-29 09:42:26,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:26 INFO - 2015-12-29 09:42:26,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 139497472 09:42:26 INFO - 2015-12-29 09:42:26,989 DEBUG : BROWSER_OUTPUT: 09:42:29 INFO - 2015-12-29 09:42:29,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60863/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:30 INFO - 2015-12-29 09:42:30,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 139304960 09:42:30 INFO - 2015-12-29 09:42:30,494 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-12-29 09:42:33,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60863/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:34 INFO - 2015-12-29 09:42:34,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 139546624 09:42:34 INFO - 2015-12-29 09:42:34,429 DEBUG : BROWSER_OUTPUT: 09:42:37 INFO - 2015-12-29 09:42:37,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60863/tests/kraken/driver.html?testName=json-parse-financial) 09:42:37 INFO - 2015-12-29 09:42:37,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 09:42:37 INFO - 2015-12-29 09:42:37,816 DEBUG : BROWSER_OUTPUT: 09:42:39 INFO - 2015-12-29 09:42:39,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:39 INFO - 2015-12-29 09:42:39,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 139190272 09:42:39 INFO - 2015-12-29 09:42:39,952 DEBUG : BROWSER_OUTPUT: 09:42:41 INFO - 2015-12-29 09:42:41,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:42 INFO - 2015-12-29 09:42:42,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 138547200 09:42:42 INFO - 2015-12-29 09:42:42,288 DEBUG : BROWSER_OUTPUT: 09:42:44 INFO - 2015-12-29 09:42:44,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:44 INFO - 2015-12-29 09:42:44,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 138276864 09:42:44 INFO - 2015-12-29 09:42:44,918 DEBUG : BROWSER_OUTPUT: 09:42:47 INFO - 2015-12-29 09:42:47,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:47 INFO - 2015-12-29 09:42:47,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 139689984 09:42:47 INFO - 2015-12-29 09:42:47,920 DEBUG : BROWSER_OUTPUT: 09:42:50 INFO - 2015-12-29 09:42:50,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:51 INFO - 2015-12-29 09:42:51,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 139952128 09:42:51 INFO - 2015-12-29 09:42:51,015 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60863/tests/kraken/driver.html?testName=ai-astar) 09:42:52 INFO - 2015-12-29 09:42:52,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 138911744 09:42:52 INFO - 2015-12-29 09:42:52,922 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,924 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:42:52 INFO - 2015-12-29 09:42:52,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:42:52 INFO - 2015-12-29 09:42:52,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:42:52 INFO - 2015-12-29 09:42:52,925 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:42:52 INFO - 2015-12-29 09:42:52,925 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;110;111;111;120;112;111;112;112 09:42:52 INFO - 2015-12-29 09:42:52,925 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;122;144;158;123;145;148;126;167;132 09:42:52 INFO - 2015-12-29 09:42:52,925 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;162;162;163;162;161;162;165;161 09:42:52 INFO - 2015-12-29 09:42:52,926 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;74;72;165;71;74;71;72;161;73 09:42:52 INFO - 2015-12-29 09:42:52,926 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;148;93;93;93;141;92;94;145 09:42:52 INFO - 2015-12-29 09:42:52,926 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;110;110;110;109;109 09:42:52 INFO - 2015-12-29 09:42:52,926 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;147;148;147;146;145 09:42:52 INFO - 2015-12-29 09:42:52,927 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;96;97;95;96;95 09:42:52 INFO - 2015-12-29 09:42:52,927 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;59;58;61;62;60;61;59;58 09:42:52 INFO - 2015-12-29 09:42:52,927 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;62;62;63;64;64;63;64;63;63 09:42:52 INFO - 2015-12-29 09:42:52,927 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;82;85;84;84;84;83;83;84;85 09:42:52 INFO - 2015-12-29 09:42:52,928 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;110;126;119;115;115;125;127;114;111 09:42:52 INFO - 2015-12-29 09:42:52,928 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;143;155;147;144;135;148;150;146;136 09:42:52 INFO - 2015-12-29 09:42:52,928 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;67;65;69;66;67;67;64;71;65 09:42:52 INFO - 2015-12-29 09:42:52,929 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:42:52 INFO - 2015-12-29 09:42:52,929 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:42:52 INFO - 2015-12-29 09:42:52,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 09:42:52 INFO - 2015-12-29 09:42:52,929 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:42:52 INFO - 2015-12-29 09:42:52,929 DEBUG : BROWSER_OUTPUT: __startTimestamp1451410972923__endTimestamp 09:42:52 INFO - 2015-12-29 09:42:52,930 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,931 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:42:52 INFO - 2015-12-29 09:42:52,931 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:42:52 INFO - 2015-12-29 09:42:52,932 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,932 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:3.44 (3.1%) stddev-sans-first:3.64 09:42:52 INFO - 2015-12-29 09:42:52,932 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 110.0 111.0 111.0 120.0 112.0 111.0 112.0 112.0 09:42:52 INFO - 2015-12-29 09:42:52,933 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,933 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:146.50 stddev:15.60 (10.7%) stddev-sans-first:15.92 09:42:52 INFO - 2015-12-29 09:42:52,933 DEBUG : BROWSER_OUTPUT: Values: 154.0 122.0 144.0 158.0 123.0 145.0 148.0 126.0 167.0 132.0 09:42:52 INFO - 2015-12-29 09:42:52,933 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,933 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 09:42:52 INFO - 2015-12-29 09:42:52,933 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 162.0 162.0 163.0 162.0 161.0 162.0 165.0 161.0 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.20 Median:72.50 stddev:37.92 (52.3%) stddev-sans-first:39.97 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: Values: 79.0 74.0 72.0 165.0 71.0 74.0 71.0 72.0 161.0 73.0 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.50 stddev:25.16 (27.2%) stddev-sans-first:25.98 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 148.0 93.0 93.0 93.0 141.0 92.0 94.0 145.0 09:42:52 INFO - 2015-12-29 09:42:52,934 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 147.0 148.0 147.0 146.0 145.0 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 09:42:52 INFO - 2015-12-29 09:42:52,935 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.50 stddev:1.43 (2.4%) stddev-sans-first:1.41 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 59.0 58.0 61.0 62.0 60.0 61.0 59.0 58.0 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:0.78 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 62.0 63.0 64.0 64.0 63.0 64.0 63.0 63.0 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,936 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.17 (2.6%) stddev-sans-first:0.97 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: Values: 90.0 82.0 85.0 84.0 84.0 84.0 83.0 83.0 84.0 85.0 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:117.50 stddev:6.20 (5.3%) stddev-sans-first:6.54 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: Values: 116.0 110.0 126.0 119.0 115.0 115.0 125.0 127.0 114.0 111.0 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:146.50 stddev:7.26 (5.0%) stddev-sans-first:6.37 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: Values: 132.0 143.0 155.0 147.0 144.0 135.0 148.0 150.0 146.0 136.0 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-29 09:42:52,937 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:2.12 (3.2%) stddev-sans-first:2.17 09:42:52 INFO - 2015-12-29 09:42:52,938 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 65.0 69.0 66.0 67.0 67.0 64.0 71.0 65.0 09:42:52 INFO - 2015-12-29 09:42:52,938 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:42:52 INFO - 2015-12-29 09:42:52,938 DEBUG : BROWSER_OUTPUT: 09:42:53 INFO - 2015-12-29 09:42:53,745 INFO : Browser exited with error code: 0 09:42:53 INFO - 2015-12-29 09:42:53,801 INFO : Completed test kraken (00:00:58) 09:42:53 INFO - 2015-12-29 09:42:53,801 INFO : Starting test v8_7 09:42:53 INFO - 2015-12-29 09:42:53,801 DEBUG : operating with platform_type : linux_ 09:42:53 INFO - 2015-12-29 09:42:53,802 INFO : Initialising browser for v8_7 test... 09:42:53 INFO - 2015-12-29 09:42:53,807 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg8mgbs/profile http://localhost:60863/getInfo.html 09:42:57 INFO - 2015-12-29 09:42:57,926 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:42:57 INFO - 2015-12-29 09:42:57,926 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:42:57 INFO - 2015-12-29 09:42:57,926 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:42:57 INFO - 2015-12-29 09:42:57,926 DEBUG : BROWSER_OUTPUT: __metrics 09:42:58 INFO - 2015-12-29 09:42:58,869 INFO : Browser initialized. 09:42:58 INFO - 2015-12-29 09:42:58,870 INFO : Running cycle 1/1 for v8_7 test... 09:42:58 INFO - 2015-12-29 09:42:58,870 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg8mgbs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:43:10 INFO - 2015-12-29 09:43:10,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 09:43:10 INFO - 2015-12-29 09:43:10,587 DEBUG : BROWSER_OUTPUT: 09:43:31 INFO - 2015-12-29 09:43:31,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60863/tests/v8_7/run.html (next: http://localhost:60863/tests/v8_7/run.html) 09:43:32 INFO - 2015-12-29 09:43:32,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 136253440 09:43:32 INFO - 2015-12-29 09:43:32,168 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,169 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:43:32 INFO - 2015-12-29 09:43:32,170 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:43:32 INFO - 2015-12-29 09:43:32,170 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:43:32 INFO - 2015-12-29 09:43:32,170 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:43:32 INFO - 2015-12-29 09:43:32,171 DEBUG : BROWSER_OUTPUT: |0;Richards;168.57720836142954 09:43:32 INFO - 2015-12-29 09:43:32,171 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.44809109176154 09:43:32 INFO - 2015-12-29 09:43:32,171 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 09:43:32 INFO - 2015-12-29 09:43:32,171 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 09:43:32 INFO - 2015-12-29 09:43:32,171 DEBUG : BROWSER_OUTPUT: |4;RayTrace;900.9009009009009 09:43:32 INFO - 2015-12-29 09:43:32,172 DEBUG : BROWSER_OUTPUT: |5;Earley;551.8763796909492 09:43:32 INFO - 2015-12-29 09:43:32,172 DEBUG : BROWSER_OUTPUT: |6;Boyer;11021.978021978022 09:43:32 INFO - 2015-12-29 09:43:32,172 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 09:43:32 INFO - 2015-12-29 09:43:32,172 DEBUG : BROWSER_OUTPUT: |8;Splay;531.632110579479 09:43:32 INFO - 2015-12-29 09:43:32,172 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:43:32 INFO - 2015-12-29 09:43:32,172 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: __startTimestamp1451411012168__endTimestamp 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.58 Median:168.58 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: Values: 168.6 09:43:32 INFO - 2015-12-29 09:43:32,173 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: Values: 167.4 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: Values: 280.5 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: Values: 5186.5 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,174 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:900.90 Median:900.90 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: Values: 900.9 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.88 Median:551.88 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: Values: 551.9 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11021.98 Median:11021.98 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: Values: 11022.0 09:43:32 INFO - 2015-12-29 09:43:32,175 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: Values: 26000.0 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:531.63 Median:531.63 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: Values: 531.6 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:43:32 INFO - 2015-12-29 09:43:32,176 DEBUG : BROWSER_OUTPUT: 09:43:33 INFO - 2015-12-29 09:43:33,002 INFO : Browser exited with error code: 0 09:43:33 INFO - 2015-12-29 09:43:33,016 INFO : Completed test v8_7 (00:00:39) 09:43:33 INFO - 2015-12-29 09:43:33,251 INFO : Completed test suite (00:20:06) 09:43:33 INFO - 2015-12-29 09:43:33,252 DEBUG : Working with test: dromaeo_css 09:43:33 INFO - 2015-12-29 09:43:33,252 DEBUG : Generating results file: dromaeo_css 09:43:33 INFO - 2015-12-29 09:43:33,253 DEBUG : Working with test: kraken 09:43:33 INFO - 2015-12-29 09:43:33,253 DEBUG : Generating results file: kraken 09:43:33 INFO - 2015-12-29 09:43:33,253 INFO : javascript benchmark 09:43:33 INFO - 2015-12-29 09:43:33,253 DEBUG : Working with test: v8_7 09:43:33 INFO - 2015-12-29 09:43:33,254 DEBUG : Generating results file: v8_7 09:43:33 INFO - 2015-12-29 09:43:33,254 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:33 INFO - 2015-12-29 09:43:33,305 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:43:33 INFO - 2015-12-29 09:43:33,306 DEBUG : process_Request line: dromaeo_css 7354.62 graph.html#tests=[[72,52,43]] 09:43:33 INFO - 2015-12-29 09:43:33,306 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:33 INFO - 2015-12-29 09:43:33,344 DEBUG : process_Request line: kraken 1501.80 graph.html#tests=[[232,52,43]] 09:43:33 INFO - 2015-12-29 09:43:33,345 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:33 INFO - 2015-12-29 09:43:33,389 DEBUG : process_Request line: v8_7 22999.50 graph.html#tests=[[230,52,43]] 09:43:33 INFO - 2015-12-29 09:43:33,391 INFO : javascript benchmark 09:43:33 INFO - 2015-12-29 09:43:33,394 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3365.713914317283, 3377.273886114485, 3401.2007178313092, 3428.8457019434113, 3440.8967730968066, 5615.0173719599115, 5669.659820410773, 5690.260266165403, 5696.25948626679, 5711.657300561958, 5663.461971112748, 5696.401877802823, 5722.914156287659, 5723.885522289552, 5730.226419433376, 5201.0378080055125, 5208.2968799212, 5238.345206849144, 5268.868278293055, 5274.0, 5064.265681476184, 5126.512981266774, 5129.717865517395, 5165.664231824938, 5264.184051472028, 5149.871253218681, 5222.164453687411, 5226.451222621627, 5228.032813929416, 5228.843134705965, 5161.9159976405, 5197.636165468419, 5270.1040823060175, 5283.207518872162, 5289.761960711778, 4981.900361992776, 5055.545000949895, 5091.79632814687, 5151.098557752416, 5156.1750119980625, 5489.423610520877, 5510.421405752379, 5537.667739935617, 5572.052751032294, 5574.470425309589, 6114.327423983358, 6137.693115344215, 6177.289611694668, 6188.845278868064, 6191.9690401547705, 6073.878522429527, 6131.621347939075, 6146.078088286748, 6207.751689932397, 6227.408396202353, 5770.6249093808765, 5779.422057794229, 5784.4504772046585, 5796.739146738365, 5796.942030579682, 6236.688165591702, 6247.9062814057825, 6260.24877014752, 6272.655003974825, 6299.842503937438, 5820.272465941757, 5992.250968628921, 6028.849278768066, 6091.725872335755, 6156.353582873734, 6069.969650151721, 6088.4824789893355, 6119.5104391648565, 6151.661658608819, 6161.44546990773, 5980.073088671263, 6067.0, 6089.665068421191, 6099.878002440015, 6103.664298463627, 6021.3677563856045, 6058.27300723916, 6099.054646529795, 6136.171616831671, 6137.294211165684, 4687.507811679793, 4696.835610753676, 4699.882502937454, 4707.576318131385, 4736.834210802605, 4118.691098167649, 4191.685623578243, 4228.957710422918, 4236.809343579546, 4279.828806847691, 5788.0449725795615, 5856.180134781134, 5862.70686465675, 5872.647641141545, 5939.10913362999, 6165.290991536031, 6173.444390004921, 6178.505719542426, 6194.256689197326, 6215.81352559424, 5535.833924982257, 5724.112762521816, 5730.426957304237, 5887.499562537232, 5901.793437229762, 5235.424103348629, 5262.3158989331905, 5272.393674727456, 5281.894362112813, 5288.391834938954, 6327.96836015817, 6348.269948955837, 6354.936450635527, 6355.745770169141, 6390.233172019387, 6112.908306375497, 6141.508679305555, 6147.569670123048, 6181.99999999991, 6215.875682486416, 6102.7253773579405, 6139.539534534839, 6188.071789231652, 6412.6152430852435, 6429.292777794345, 5953.851153721018, 6001.7299221536005, 6037.124616930609, 6039.305479869696, 6098.146259523582, 5846.298444186725, 6136.325004249618, 6137.785177518944, 6148.323684394623, 6164.352742961924, 5878.647281163144, 5979.790707325223, 5982.192404025401, 5983.0, 6010.789622363196, 5948.613340132878, 5988.490978266722, 5989.221401217814, 6026.548008899438, 6061.545384096122, 5724.398938111438, 5848.883022339614, 5914.58597898143, 5931.9110213345975, 5942.7920022799, 6026.879462410815, 6067.878642427038, 6085.847853803691, 6103.42017508336, 6103.633781973096, 5806.042003069446, 5864.853378665397, 5920.023196172756, 5924.822255332347, 5936.1095835625], "unit": "ms", "name": "dojo.html", "value": 5643.040784544724}, {"lowerIsBetter": false, "replicates": [573.498189084551, 615.1295916278466, 616.238944903045, 620.5439002333284, 653.6862306093078, 31509.369812603763, 32506.349873002524, 39858.800705996466, 40099.59900400995, 40367.0, 44972.77513612428, 45453.0, 45477.31784023243, 45522.317165242544, 45681.31478027832, 9142.542872856364, 9268.907310926872, 9301.627934882597, 9323.160915517603, 9335.813283734322, 8966.686165984192, 9075.410098343587, 9081.682141125062, 9095.499747513884, 9102.63589456421, 9073.455592664428, 9199.080091990782, 9202.815943681122, 9204.907950920471, 9231.723048308562, 9117.817643647157, 9123.406978546407, 9160.72517824463, 9176.03651616584, 9193.999999999967, 9018.639254429814, 9166.312526560534, 9170.770730731785, 9171.0, 9200.539973001323, 41976.58023419788, 42381.0, 42640.0, 42645.786771066254, 42661.786691066656, 3460.653934606544, 3491.3513782961863, 3549.3078849624335, 3578.556532732092, 3587.031501494608, 31573.0, 32182.356352872812, 32234.516482252784, 32257.0, 32731.18172045694, 4025.215083058805, 4096.713230073896, 4170.145120250341, 4187.183499217654, 4218.029853133797, 286857.0, 286975.0, 288131.9999999979, 288702.0, 289411.0, 44219.557804422184, 44742.77628611836, 44981.55018449839, 45008.32487512624, 61678.383216168164, 43799.56200437955, 43888.561114389086, 43896.024678889524, 43974.0, 43989.560104398544, 16562.0, 16877.07176105326, 16956.74564881528, 17008.31966721342, 17061.232244549024, 13636.113652612548, 13873.722525549634, 13879.4448222072, 13898.0, 13966.511172108927, 15218.847811521964, 15237.238138093273, 15238.238088095552, 15322.080675159303, 15342.463013794464, 6126.203593532812, 6261.8747625047245, 6294.559380843389, 6334.144890439732, 6366.395192456709, 1006.7533454303742, 1114.164376717462, 1120.4230717518865, 1138.1463902073444, 1157.2246594781516, 33534.49698254528, 33695.4945675815, 34298.0, 34440.82779586136, 34606.480902786476, 1075.9031687148195, 1081.588996181446, 1085.847981282621, 1150.9597164099216, 1173.9941300293444, 15205.239738013055, 15290.388384464497, 15466.952632023074, 15595.922020389826, 15806.9209653951, 443058.0, 624472.0, 739579.0, 750039.0, 756141.0, 57139.428605714245, 58020.0, 58588.12117818236, 58711.412885870595, 58762.41237587655, 1488.5013520470764, 1504.3907217576898, 1517.5068102866612, 1518.0663891706522, 1524.885633577486, 30222.244443888198, 31228.0, 31326.530102048033, 31454.52818207683, 31839.36321273608, 49815.50184498109, 49909.0, 50297.24554131618, 50448.24327635162, 50452.24321635105, 331882.0, 331977.0, 333588.0, 335196.0, 335925.0, 34310.31379372448, 34885.0, 34999.0, 35085.0, 35284.0, 45632.77183614193, 46077.0, 46482.07035859196, 46788.0, 47162.0, 38651.0, 38883.61116388913, 39872.601273988046, 39895.2020959585, 40473.98815029648, 39040.0, 39384.6061539381, 39412.40881386839, 39653.60346396499, 39958.800205998785, 38253.42619860649, 38410.231795364496, 38647.0, 38690.6130938687, 38813.223735525695, 34605.48091778575, 34614.82692586521, 35116.473252900716, 35225.823870881504, 35287.82356088203, 26172.214833555023, 26319.21042368732, 26461.0, 26658.0, 27180.456390872467], "unit": "ms", "name": "ext.html", "value": 19594.409682778718}, {"lowerIsBetter": false, "replicates": [391.2039000633711, 394.07196053294484, 397.25514660012476, 397.7851959941632, 400.4673783867456, 15879.603009924758, 16663.50009499714, 17389.56526086847, 19725.112369943352, 19798.505037374074, 11762.176647634647, 12229.571964981227, 12299.569515066974, 12433.440495177716, 12472.625821225378, 5252.947470525303, 5264.263003179539, 5366.812161574346, 5367.436419175989, 5371.81198658047, 5204.531592156705, 5317.803494213809, 5443.972780136094, 5515.062439385294, 5530.087535556649, 5463.972680136594, 5473.698946557938, 5496.862578435531, 5562.221289019541, 5804.9419505805035, 5752.165935939307, 5761.740721667514, 5786.132080187964, 5797.36229014808, 5804.158397032449, 5419.295491586068, 5468.207109969072, 5493.395726470085, 5577.637453565505, 5580.302462192226, 13389.732205355838, 13467.124636898669, 13590.116642418212, 18558.90720546402, 21494.677579836316, 2283.8743869087193, 2294.9311520654405, 2306.3081075677396, 2306.4810417656063, 2341.555104530134, 10045.89954100457, 10370.948145259226, 10393.79212415755, 11934.582289619822, 14381.0, 1936.893470859102, 1996.2214736252872, 1999.990000050005, 2023.7773844877051, 2040.1533363654066, 64308.356916430705, 66760.33239667541, 67554.66222668905, 68610.3138968614, 69513.65243173802, 10357.378557286587, 10374.688759337232, 10383.792324153626, 10560.0, 10720.731981700364, 13266.204027758366, 13316.600501984956, 13326.466941322433, 13353.73292534144, 13357.799633005512, 8160.143184965612, 8263.214994575506, 8291.626876790559, 8306.08633050364, 8378.371622128243, 8393.664253429795, 8393.790155246168, 8401.915980840113, 8425.957870210732, 8431.325493960469, 4078.1232035112594, 4261.105167914772, 4311.784410779448, 4315.633171180485, 4487.910241795146, 1815.110595808071, 1855.4340926017694, 1861.944141675752, 1888.4429093417475, 1948.581055073166, 487.14506041896954, 950.9286803489628, 1040.812653722322, 1054.8786889507805, 1095.6658219243207, 11050.778984420267, 11212.719682008015, 11235.94382028101, 11405.657830265105, 11429.942850285861, 479.08494774979624, 492.6576029659352, 494.4141192686678, 497.6044044984246, 502.0661569480763, 6199.876002480015, 6299.370062993664, 6300.401461861115, 6338.271098823602, 6380.808575742735, 651102.0, 654971.0, 657941.0, 672349.0, 681462.0, 84574.0, 86297.56851215704, 86644.56677716572, 87896.0, 88052.11947880567, 1186.602488166474, 1193.5643490126042, 1199.898008669273, 1200.0699457920007, 1200.7778560966249, 16506.83493165053, 16622.750658739886, 16635.085070320765, 16663.833361666228, 17039.744403833705, 37384.439233412064, 37502.249955001294, 37504.0, 38680.41979370255, 38996.805015974736, 51450.0, 51679.74160129175, 51797.0, 52256.21615675692, 54534.727326363114, 10069.395836249849, 10075.647352342927, 10333.379997200193, 10400.27198096126, 10417.166626669698, 12192.0, 14052.437902483785, 16344.0, 17850.642987140443, 17917.104144792447, 14705.0, 14900.552983410515, 15035.849641503444, 15408.768868466757, 15527.146006969726, 14718.55844324672, 15220.847791521943, 15338.233088345314, 15666.138362390178, 16039.438619648723, 15381.538553843402, 15744.68510629758, 15791.842081579496, 15849.920750396173, 16075.839241607435, 10383.740406489898, 10446.529906154394, 10546.630867919894, 10609.257351985287, 10650.307729997525, 10977.3962432067, 11040.779184416428, 14331.856681433052, 15808.92095539515, 15947.043177409392], "unit": "ms", "name": "jquery.html", "value": 8853.06286722108}, {"lowerIsBetter": false, "replicates": [1460.8539146085393, 1473.3369983507419, 1666.8583170430513, 1797.1014492753623, 1836.9712960741986, 7893.565853878034, 8068.838623227532, 8127.065387480441, 8270.462419942707, 8273.50358978461, 8261.173882611736, 8282.33741300696, 8410.537420441873, 8415.452995555284, 8422.28410585101, 2364.8226383021256, 2392.258399896029, 2397.3646983549374, 2414.6015907375263, 2418.3470462974988, 2336.649502574619, 2382.690250267463, 2383.940401489959, 2401.0635852017726, 2406.651035599837, 2280.053777682268, 2293.885305734715, 2328.208409140892, 2371.3123194273726, 2400.59189937711, 2304.6312589985523, 2319.2694301295037, 2342.7422983471806, 2345.812335013195, 2347.5891718949115, 2279.566882292376, 2318.8724620145886, 2328.662343960133, 2334.8015418689433, 2342.5666251743482, 7939.166387529284, 7972.724364101774, 7983.920160798376, 7997.560134192617, 8027.598620068973, 4793.18515852306, 4887.755612219375, 4916.139675556799, 4917.680350777224, 4948.282499037619, 3220.533022711694, 3249.23642943908, 3284.0312107928216, 3325.3681800457834, 3325.90022299329, 1031.6698656429946, 1044.3107549017611, 1062.5324857062867, 1094.496531595467, 1101.091599430473, 10968.945155274252, 11003.669889903316, 11007.834882476769, 11012.17408694351, 11031.61389351377, 4359.564043595615, 4407.955920440754, 4428.601425871622, 4464.06254686513, 4466.419365482467, 9024.097590240923, 9046.728598142066, 9048.819023619491, 9049.321300902458, 9101.726948191565, 4971.825986090469, 4990.5508504234795, 5002.649814512949, 5008.273800298936, 5026.29631851541, 4565.086982603492, 4580.564846339593, 4591.449026116888, 4609.907801843944, 4612.838550650711, 3632.8728494503093, 3684.9447258291148, 3717.683996860243, 3725.2549490102087, 3737.4206997915367, 1103.5199688135688, 1117.6702872652425, 1128.700894263021, 1129.3280498103616, 1143.2854465958776, 1018.5721996761378, 1021.5352014833232, 1136.4942600542845, 1312.1077667186214, 1433.0756661952983, 7558.735444259424, 7580.658870350848, 7634.274743899321, 7634.351080158138, 7698.461107722405, 676.8815457294953, 682.5461068389565, 690.6132565763189, 697.3026973026973, 834.1616675241344, 5809.68046757424, 5839.270091238595, 5839.766409343579, 5853.268341457318, 5856.0630299151935, 9276.072392760805, 9461.148496635336, 9640.0, 9747.366421182742, 9837.950810245902, 9546.284028697875, 9590.952045239868, 9662.13040826329, 9671.516424178762, 9737.513124343754, 7345.449091318173, 7399.963000184965, 7625.542467451971, 7651.0, 7674.923250767532, 7413.925860741324, 7417.592032438268, 7436.4050875928715, 7459.477836551607, 7466.216047315171, 8391.748247552583, 8564.186402291773, 8625.784355391166, 8651.221390074923, 8690.34822388336, 8742.0, 8834.028256891865, 8846.557672116498, 8863.734087977371, 8866.911330886609, 6934.479914006571, 6958.582485050913, 6965.059716938148, 6980.7207711693, 6995.370416662525, 7903.604819758874, 7909.7231596893835, 7913.643886025027, 7936.722214722457, 7946.086200087064, 7076.752313668997, 7284.125904891447, 7309.0, 7335.0, 7477.102747670315, 7010.929890701028, 7087.0, 7247.2390399007345, 7257.52826066304, 7350.338469537767, 7037.542559733601, 7072.893906591303, 7111.146662400545, 7114.430845532448, 7127.786166415016, 6817.420519255918, 6852.897206542006, 6879.552829066095, 6881.41507971828, 6904.240533541407, 6421.71102300407, 6629.270780214269, 6668.166479190101, 6700.396964273239, 6732.394084532416], "unit": "ms", "name": "mootools.html", "value": 4585.874969683675}, {"lowerIsBetter": false, "replicates": [366.44666553504203, 369.82618169460346, 371.9349113905066, 374.2160174434559, 376.19306587370085, 6220.440160385564, 6307.716152773125, 6314.336994615563, 6356.332585078564, 6463.967680161599, 6163.013917773157, 6300.275468321144, 6306.05409188622, 6319.052142178675, 6322.399372059647, 4900.730459824708, 4905.828296009631, 4914.164592019365, 4914.97542512287, 4936.580390666798, 4915.041566894439, 4933.062718083571, 4935.629827762914, 4936.481669424713, 4954.578860796837, 4685.109829132454, 4801.0, 4805.063012712522, 4813.735244561548, 4813.831515896944, 4790.736509491977, 4792.904141917177, 4808.927866082012, 4818.566329030404, 4848.418189817209, 4209.74741515507, 4233.830646774125, 4246.214450326699, 4249.213895429355, 4254.0, 5945.583809133363, 5969.074793407029, 6039.4262545058145, 6046.909296360558, 6067.150598916155, 5636.830895073113, 5669.376368599451, 5674.404187560329, 5686.317641882959, 5688.345840228385, 6686.699098540577, 6714.83212919676, 6727.428168605675, 6728.259891411941, 6730.697118629624, 4657.976710116462, 4675.696079754805, 4686.601638860701, 4695.929561056552, 4727.456342520585, 6911.3779759821855, 6971.372576468142, 6997.405220556258, 7045.894311585279, 7048.365647091787, 4805.807767689324, 4809.927851082237, 4810.6632535722865, 4818.855434336975, 4819.831305904277, 4872.610191184696, 4885.316055752198, 4886.120498310338, 4888.951110488921, 4890.584300334512, 5551.7779288828, 5639.182318563785, 5644.379118296984, 5645.4072322405555, 5645.689487078168, 6765.560238584476, 6815.114035175396, 6819.863602727918, 6823.147106611674, 6844.247132815386, 1688.5103320037297, 1724.3619860651388, 1724.8965062096315, 1727.7408388741537, 1729.5935455168026, 1152.976940461203, 1166.4925757295434, 1175.341808587194, 1176.211938001524, 1181.3856794466828, 6501.869962600722, 6576.704048317837, 6587.077809106729, 6596.0, 6597.538172327891, 6941.930580694128, 6945.236024037352, 6953.33943275388, 6958.443324534025, 6970.302969702989, 6457.160569125984, 6575.145231119924, 6581.0, 6592.241892182365, 6594.175728033996, 3732.7760334380023, 3761.2665530221343, 3771.773693578394, 3780.4140358243967, 3788.0, 7139.464540159509, 7145.21402645719, 7157.2127066022695, 7160.462965277521, 7168.139823221247, 7064.50548461613, 7094.751683691046, 7134.571925684476, 7151.964240178766, 7324.974503569504, 7213.1704853942465, 7317.341439270384, 7320.231375705474, 7325.0, 7328.743493977685, 7089.184743754328, 7109.431245500451, 7117.1459424869345, 7124.964375178091, 7134.250903655042, 6886.758963436256, 6945.548539344926, 6987.196472405739, 7000.229974702676, 7005.369516743517, 7239.095113110861, 7299.233580474186, 7302.96348518254, 7309.817254568678, 7314.122305323395, 4742.928856067093, 4804.639652026042, 4807.182778927521, 4812.422509298906, 4820.855374338776, 6955.513114081966, 6958.165020197406, 7032.5077244592385, 7061.752838650623, 7142.142942846892, 6917.827054323682, 6935.687894044881, 6940.826479338057, 6955.965220174069, 6967.895481567679, 6905.792826215222, 6929.7228110875, 6936.7225310987, 6937.098177237129, 6937.445004399737, 6647.867042659023, 6736.797896063126, 6797.728090876507, 6804.897926531205, 6814.897776533257, 6920.653967301715, 6950.687219075053, 6953.096097507291, 6966.12923384577, 6975.581465112109, 6710.745110460006, 6788.456923446014, 6794.456443484411, 6796.150481189851, 6808.217055038536], "unit": "ms", "name": "prototype.html", "value": 5133.974434302983}, {"lowerIsBetter": false, "replicates": [844.5355054719904, 893.9865902011471, 903.6746771162381, 907.4918045894295, 956.4500412262948, 13932.373043213054, 14133.152010879354, 14535.127892326467, 14545.909056820741, 14551.708965820677, 14583.197924114169, 14702.411903523873, 14723.999999999973, 14751.77872331916, 14755.26223688814, 741.9406447484188, 744.4342299852125, 901.6168128545359, 916.408916249019, 918.5636822509322, 903.661127077346, 904.8687940248693, 905.0496978172893, 912.8493798523235, 913.6162811619135, 961.4808003678005, 967.3277072434661, 967.569431602937, 969.4328817641688, 973.4597298499366, 958.6021800952597, 963.0802583532779, 963.5375019990408, 963.6097380560849, 967.2068903499134, 699.3356311504092, 708.8617719544691, 711.8433944532195, 712.1560950273941, 713.0338391479575, 13394.928405727518, 13507.932460337635, 13510.932445337809, 13544.187348759106, 13546.45814167432, 13036.543720969721, 13042.934785326108, 13418.0, 13433.66415839602, 13534.0, 11126.721831954184, 11314.264572802742, 11372.886271137348, 11419.25774824642, 11485.310881347146, 3843.4619153318276, 3877.0, 3906.8437262509465, 3910.1397692507603, 3911.2177564487215, 47317.0, 47851.99999999965, 47896.760516197544, 48832.26751598729, 49100.75449622729, 10357.585696572052, 10361.326513776581, 10377.688669339932, 10534.841977370346, 10899.673009809718, 18887.0, 19482.80517194838, 19529.218831246875, 19650.803491965184, 19781.208751649774, 7919.6832126715435, 8003.439759216915, 8060.516369017878, 8135.227153420416, 8309.95845020771, 4738.099761045391, 4781.876259079114, 4864.343313652683, 4964.478729733326, 4965.3048573199785, 3353.748468864845, 3366.882159124419, 3382.458806590934, 3385.3398587275738, 3385.509101180315, 609.9664518451439, 623.2925629410652, 625.293418437163, 627.6516533323958, 641.3522342434175, 738.9567844908831, 739.2311995524701, 747.689708770854, 762.1616222155584, 774.71722821171, 9245.260379169651, 9632.855507167398, 9700.078492543196, 9705.757356066155, 9804.754881128029, 684.2985939412142, 731.3016069653468, 736.752903643884, 738.2027410396759, 755.6737924941692, 4246.214450326699, 4589.609883159902, 4606.216943119678, 4632.305154226893, 4679.883002924886, 60121.398786012454, 60302.0, 60771.0, 64142.67928660327, 64312.35687643157, 53348.73325633347, 53825.730871346175, 54592.45407545953, 54854.725726371114, 55145.44854551483, 49278.26082608764, 49456.0, 49459.75270123626, 49823.99999999927, 50413.74793126084, 9658.034196580285, 9696.612135514782, 9841.85237221428, 9846.777156589189, 9890.14824750805, 35414.82292588521, 36207.094822629646, 37037.25925481529, 37422.625773741915, 37630.247395051396, 46414.535854642374, 47450.28824567565, 47540.52459475499, 47684.0, 48819.5118048815, 10939.671809845717, 11096.889031109586, 11120.499577519193, 11905.761884762429, 11964.820527691918, 13322.866771332163, 13619.38712757948, 13680.589582312547, 13867.167969921837, 14411.063280886709, 11715.121365897763, 11801.168077845585, 11897.40512974365, 11967.461464234304, 12030.518779249081, 12421.37893105323, 12880.0, 12905.0, 13136.671583210114, 13189.472421103048, 11873.643790686294, 12030.578929737418, 12062.155649104478, 12163.45264463119, 12383.133180677267, 9922.801543969224, 10182.592696292066, 10204.948975255076, 10438.791224175322, 10717.464126793786, 9627.133557979816, 10295.279330447096, 10306.793864122825, 10341.896581034394, 10361.378317300987], "unit": "ms", "name": "yui.html", "value": 6866.142511279434}], "name": "dromaeo_css", "value": 7354.627425831496}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 111.0, 111.0, 120.0, 112.0, 111.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 144.0, 158.0, 123.0, 145.0, 148.0, 126.0, 167.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 165.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [79.0, 74.0, 72.0, 165.0, 71.0, 74.0, 71.0, 72.0, 161.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 148.0, 93.0, 93.0, 93.0, 141.0, 92.0, 94.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 59.0, 58.0, 61.0, 62.0, 60.0, 61.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 62.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.9}, {"lowerIsBetter": true, "replicates": [90.0, 82.0, 85.0, 84.0, 84.0, 84.0, 83.0, 83.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [116.0, 110.0, 126.0, 119.0, 115.0, 115.0, 125.0, 127.0, 114.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [132.0, 143.0, 155.0, 147.0, 144.0, 135.0, 148.0, 150.0, 146.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 69.0, 66.0, 67.0, 67.0, 64.0, 71.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1501.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.57720836142954], "unit": "score", "name": "Richards", "value": 209.41146399999997}, {"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "DeltaBlue", "value": 394.85669599999994}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [900.9009009009009], "unit": "score", "name": "RayTrace", "value": 821.3877900000001}, {"lowerIsBetter": false, "replicates": [551.8763796909492], "unit": "score", "name": "Earley", "value": 1207.6309559999997}, {"lowerIsBetter": false, "replicates": [11021.978021978022], "unit": "score", "name": "Boyer", "value": 60.46673280159525}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [531.632110579479], "unit": "score", "name": "Splay", "value": 153.28457100000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 22999.499072513558}]} 09:43:33 INFO - RETURN: dromaeo_css: 7354.62 09:43:33 INFO - RETURN: kraken: 1501.80 09:43:33 INFO - RETURN: v8_7: 22999.50 09:43:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22999.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7354.62"}}} 09:43:33 INFO - Return code: 0 09:43:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:43:33 INFO - # TBPL SUCCESS # 09:43:33 INFO - Running post-action listener: _resource_record_post_action 09:43:33 INFO - Running post-run listener: _resource_record_post_run 09:43:34 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503173120; Read time: 72; Write time: 441652 09:43:34 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 236724224; Read time: 0; Write time: 297088 09:43:34 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 8192; Write bytes: 266448896; Read time: 72; Write time: 144564 09:43:34 INFO - Running post-run listener: _upload_blobber_files 09:43:34 INFO - Blob upload gear active. 09:43:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:43:34 INFO - Copying logs to upload dir... 09:43:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.166593 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-29 09:43:34.181434) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-29 09:43:34.184733) ========= 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009166 build_url: 'https://queue.taskcluster.net/v1/task/7DNty1OUTJmi6HXEJe3Bxg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-29 09:43:34.235421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:43:34.235736) ========= 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=f5f5a079460e1a9be8676904000001c1-1451409692.365279-537606640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 09:43:34.285452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 09:43:34.285758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 09:43:34.286218) ========= ========= Total master_lag: 0.27 =========