builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1447394795.63 results: success (0) buildid: 20151112203045 builduid: 8ad16f0e205a41779d19fde93b173b2b revision: 4b2ec935bc99bc505776190210b11dfe552bd041 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.628913) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.629653) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.630207) ========= 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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006500 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.679455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.679769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.729934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.730303) ========= 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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.782421) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.782719) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.783113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.783419) ========= 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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 22:06:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-11-12 22:06:36 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.969335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:35.969682) ========= 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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022070 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.018683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.019074) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b2ec935bc99bc505776190210b11dfe552bd041 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4b2ec935bc99bc505776190210b11dfe552bd041 --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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 22:06:36,609 truncating revision to first 12 chars 2015-11-12 22:06:36,609 Setting DEBUG logging. 2015-11-12 22:06:36,609 attempt 1/10 2015-11-12 22:06:36,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b2ec935bc99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 22:06:36,863 unpacking tar archive at: fx-team-4b2ec935bc99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.560986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.561296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.572422) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.572702) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 22:06:36.573158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-12 22:06:36.573482) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:37 INFO - MultiFileLogger online at 20151112 22:06:37 in /builds/slave/test-pgo 22:06:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:06:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:06:37 INFO - {'append_to_log': False, 22:06:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:06:37 INFO - 'blob_upload_branch': 'Fx-Team', 22:06:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:06:37 INFO - 'branch': 'Fx-Team', 22:06:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:37 INFO - 'config_files': ('talos/linux_config.py',), 22:06:37 INFO - 'default_actions': ('clobber', 22:06:37 INFO - 'read-buildbot-config', 22:06:37 INFO - 'download-and-extract', 22:06:37 INFO - 'populate-webroot', 22:06:37 INFO - 'create-virtualenv', 22:06:37 INFO - 'install', 22:06:37 INFO - 'run-tests'), 22:06:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:37 INFO - 'download_minidump_stackwalk': True, 22:06:37 INFO - 'download_symbols': 'ondemand', 22:06:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:37 INFO - 'installer_path': 'installer.exe', 22:06:37 INFO - 'log_level': 'info', 22:06:37 INFO - 'log_name': 'talos', 22:06:37 INFO - 'log_to_console': True, 22:06:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:37 INFO - 'opt_config_files': (), 22:06:37 INFO - 'pip_index': False, 22:06:37 INFO - 'sps_profile': False, 22:06:37 INFO - 'sps_profile_interval': 0, 22:06:37 INFO - 'suite': 'dromaeojs-e10s', 22:06:37 INFO - 'system_bits': '64', 22:06:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:37 INFO - 'title': 'talos-linux64-ix-067', 22:06:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:37 INFO - 'use_talos_json': True, 22:06:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:06:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:37 INFO - 'work_dir': 'build'} 22:06:37 INFO - ##### 22:06:37 INFO - ##### Running clobber step. 22:06:37 INFO - ##### 22:06:37 INFO - Running pre-action listener: _resource_record_pre_action 22:06:37 INFO - Running main action method: clobber 22:06:37 INFO - rmtree: /builds/slave/test-pgo/build 22:06:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:06:37 INFO - Running post-action listener: _resource_record_post_action 22:06:37 INFO - ##### 22:06:37 INFO - ##### Running read-buildbot-config step. 22:06:37 INFO - ##### 22:06:37 INFO - Running pre-action listener: _resource_record_pre_action 22:06:37 INFO - Running main action method: read_buildbot_config 22:06:37 INFO - Using buildbot properties: 22:06:37 INFO - { 22:06:37 INFO - "properties": { 22:06:37 INFO - "buildnumber": 327, 22:06:37 INFO - "product": "firefox", 22:06:37 INFO - "script_repo_revision": "production", 22:06:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:06:37 INFO - "repository": "", 22:06:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:06:37 INFO - "buildid": "20151112203045", 22:06:37 INFO - "slavename": "talos-linux64-ix-067", 22:06:37 INFO - "pgo_build": "True", 22:06:37 INFO - "basedir": "/builds/slave/test-pgo", 22:06:37 INFO - "project": "", 22:06:37 INFO - "platform": "ubuntu64_hw", 22:06:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:06:37 INFO - "slavebuilddir": "test", 22:06:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:06:37 INFO - "branch": "fx-team", 22:06:37 INFO - "repo_path": "integration/fx-team", 22:06:37 INFO - "stage_platform": "linux64-pgo", 22:06:37 INFO - "builduid": "8ad16f0e205a41779d19fde93b173b2b", 22:06:37 INFO - "revision": "4b2ec935bc99bc505776190210b11dfe552bd041" 22:06:37 INFO - }, 22:06:37 INFO - "sourcestamp": { 22:06:37 INFO - "repository": "", 22:06:37 INFO - "hasPatch": false, 22:06:37 INFO - "project": "", 22:06:37 INFO - "branch": "fx-team-linux64-pgo-talos", 22:06:37 INFO - "changes": [ 22:06:37 INFO - { 22:06:37 INFO - "category": null, 22:06:37 INFO - "files": [ 22:06:37 INFO - { 22:06:37 INFO - "url": null, 22:06:37 INFO - "name": "https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:06:37 INFO - } 22:06:37 INFO - ], 22:06:37 INFO - "repository": "", 22:06:37 INFO - "rev": "4b2ec935bc99bc505776190210b11dfe552bd041", 22:06:37 INFO - "who": "sendchange", 22:06:37 INFO - "when": 1447394770, 22:06:37 INFO - "number": 6656415, 22:06:37 INFO - "comments": "", 22:06:37 INFO - "project": "", 22:06:37 INFO - "at": "Thu 12 Nov 2015 22:06:10", 22:06:37 INFO - "branch": "fx-team-linux64-pgo-talos", 22:06:37 INFO - "revlink": "", 22:06:37 INFO - "properties": [ 22:06:37 INFO - [ 22:06:37 INFO - "buildid", 22:06:37 INFO - "20151112203045", 22:06:37 INFO - "Change" 22:06:37 INFO - ], 22:06:37 INFO - [ 22:06:37 INFO - "builduid", 22:06:37 INFO - "8ad16f0e205a41779d19fde93b173b2b", 22:06:37 INFO - "Change" 22:06:37 INFO - ], 22:06:37 INFO - [ 22:06:37 INFO - "pgo_build", 22:06:37 INFO - "True", 22:06:37 INFO - "Change" 22:06:37 INFO - ] 22:06:37 INFO - ], 22:06:37 INFO - "revision": "4b2ec935bc99bc505776190210b11dfe552bd041" 22:06:37 INFO - } 22:06:37 INFO - ], 22:06:37 INFO - "revision": "4b2ec935bc99bc505776190210b11dfe552bd041" 22:06:37 INFO - } 22:06:37 INFO - } 22:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:06:37 INFO - Running post-action listener: _resource_record_post_action 22:06:37 INFO - ##### 22:06:37 INFO - ##### Running download-and-extract step. 22:06:37 INFO - ##### 22:06:37 INFO - Running pre-action listener: _resource_record_pre_action 22:06:37 INFO - Running main action method: download_and_extract 22:06:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:37 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json 22:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json 22:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:06:48 INFO - Downloaded 1302 bytes. 22:06:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:06:48 INFO - Using the following test package requirements: 22:06:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'jsshell-linux-x86_64.zip'], 22:06:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06:48 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')]} 22:06:48 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:49 INFO - Downloaded 22443432 bytes. 22:06:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:06:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:06:50 INFO - Return code: 0 22:06:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:06: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')]} 22:06:50 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:03 INFO - Downloaded 22443432 bytes. 22:07:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:07:04 INFO - Return code: 0 22:07:04 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')]} 22:07:04 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:07:05 INFO - Downloaded 11131693 bytes. 22:07:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:07:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:07:05 INFO - Return code: 0 22:07: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')]} 22:07:05 INFO - https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:07:08 INFO - Downloaded 57166214 bytes. 22:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:08 INFO - mkdir: /builds/slave/test-pgo/properties 22:07:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:07:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:07:08 INFO - Contents: 22:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:08 INFO - Running post-action listener: _resource_record_post_action 22:07:08 INFO - Running post-action listener: set_extra_try_arguments 22:07:08 INFO - ##### 22:07:08 INFO - ##### Running populate-webroot step. 22:07:08 INFO - ##### 22:07:08 INFO - Running pre-action listener: _resource_record_pre_action 22:07:08 INFO - Running main action method: populate_webroot 22:07:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:07:08 INFO - '../fennec_ids.txt'], 22:07:08 INFO - 'tests': ['tcheck2']}, 22:07:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:08 INFO - '--tppagecycles', 22:07:08 INFO - '7'], 22:07:08 INFO - 'tests': ['tsvgm']}}, 22:07:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:07:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'tests': ['damp', 'tps']}, 22:07:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['damp', 'tps']}, 22:07:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:07:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:08 INFO - 'other': {'tests': ['a11yr', 22:07:08 INFO - 'ts_paint', 22:07:08 INFO - 'tpaint', 22:07:08 INFO - 'sessionrestore', 22:07:08 INFO - 'sessionrestore_no_auto_restore']}, 22:07:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['a11yr', 22:07:08 INFO - 'ts_paint', 22:07:08 INFO - 'tpaint', 22:07:08 INFO - 'sessionrestore', 22:07:08 INFO - 'sessionrestore_no_auto_restore']}, 22:07:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['a11yr', 22:07:08 INFO - 'ts_paint', 22:07:08 INFO - 'tpaint', 22:07:08 INFO - 'sessionrestore', 22:07:08 INFO - 'sessionrestore_no_auto_restore']}, 22:07:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['a11yr', 22:07:08 INFO - 'ts_paint', 22:07:08 INFO - 'tpaint', 22:07:08 INFO - 'sessionrestore', 22:07:08 INFO - 'sessionrestore_no_auto_restore']}, 22:07:08 INFO - 'other_l64': {'tests': ['a11yr', 22:07:08 INFO - 'ts_paint', 22:07:08 INFO - 'tpaint', 22:07:08 INFO - 'sessionrestore', 22:07:08 INFO - 'sessionrestore_no_auto_restore']}, 22:07:08 INFO - 'other_nol64': {'tests': ['a11yr', 22:07:08 INFO - 'ts_paint', 22:07:08 INFO - 'tpaint', 22:07:08 INFO - 'sessionrestore', 22:07:08 INFO - 'sessionrestore_no_auto_restore']}, 22:07:08 INFO - 'svgr': {'tests': ['tsvgx', 22:07:08 INFO - 'tsvgr_opacity', 22:07:08 INFO - 'tart', 22:07:08 INFO - 'tscrollx', 22:07:08 INFO - 'cart']}, 22:07:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['tsvgx', 22:07:08 INFO - 'tsvgr_opacity', 22:07:08 INFO - 'tart', 22:07:08 INFO - 'tscrollx', 22:07:08 INFO - 'cart']}, 22:07:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'tests': ['tp5o']}, 22:07:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'talos_options': ['--e10s'], 22:07:08 INFO - 'tests': ['tp5o']}, 22:07:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'talos_options': ['--xperf_path', 22:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:08 INFO - 'tests': ['tp5n']}, 22:07:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:08 INFO - 'talos_options': ['--e10s', 22:07:08 INFO - '--xperf_path', 22:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:08 INFO - 'tests': ['tp5n']}}, 22:07:08 INFO - 'talos.zip': {'path': '', 22:07:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:08 INFO - Running post-action listener: _resource_record_post_action 22:07:08 INFO - ##### 22:07:08 INFO - ##### Running create-virtualenv step. 22:07:08 INFO - ##### 22:07:08 INFO - Running pre-action listener: _resource_record_pre_action 22:07:08 INFO - Running main action method: create_virtualenv 22:07:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:07:08 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 22:07:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:07:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:08 INFO - Using real prefix '/usr' 22:07:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:07:09 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:11 INFO - Installing pip.................done. 22:07:11 INFO - Return code: 0 22:07:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:11 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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:11 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 22:07:11 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 22:07:11 INFO - Using env: {'DISPLAY': ':0', 22:07:11 INFO - 'HOME': '/home/cltbld', 22:07:11 INFO - 'LANG': 'en_US.UTF-8', 22:07:11 INFO - 'LANGUAGE': 'en_US:en', 22:07:11 INFO - 'LOGNAME': 'cltbld', 22:07:11 INFO - 'MAIL': '/var/mail/cltbld', 22:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:11 INFO - 'MOZ_NO_REMOTE': '1', 22:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:11 INFO - 'NO_EM_RESTART': '1', 22:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:11 INFO - 'SHELL': '/bin/bash', 22:07:11 INFO - 'SHLVL': '1', 22:07:11 INFO - 'TERM': 'linux', 22:07:11 INFO - 'TMOUT': '86400', 22:07:11 INFO - 'USER': 'cltbld', 22:07:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:11 INFO - '_': '/tools/buildbot/bin/python'} 22:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:11 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 22:07:11 INFO - Cleaning up... 22:07:11 INFO - Return code: 0 22:07:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:11 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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:11 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 22:07:11 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 22:07:11 INFO - Using env: {'DISPLAY': ':0', 22:07:11 INFO - 'HOME': '/home/cltbld', 22:07:11 INFO - 'LANG': 'en_US.UTF-8', 22:07:11 INFO - 'LANGUAGE': 'en_US:en', 22:07:11 INFO - 'LOGNAME': 'cltbld', 22:07:11 INFO - 'MAIL': '/var/mail/cltbld', 22:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:11 INFO - 'MOZ_NO_REMOTE': '1', 22:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:11 INFO - 'NO_EM_RESTART': '1', 22:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:11 INFO - 'SHELL': '/bin/bash', 22:07:11 INFO - 'SHLVL': '1', 22:07:11 INFO - 'TERM': 'linux', 22:07:11 INFO - 'TMOUT': '86400', 22:07:11 INFO - 'USER': 'cltbld', 22:07:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:11 INFO - '_': '/tools/buildbot/bin/python'} 22:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:11 INFO - Downloading/unpacking psutil>=0.7.1 22:07:11 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 22:07:11 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 22:07:11 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 22:07:11 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 22:07:11 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 22:07:11 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 22:07:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:07:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:13 INFO - Installing collected packages: psutil 22:07:13 INFO - Running setup.py install for psutil 22:07:13 INFO - building 'psutil._psutil_linux' extension 22:07:13 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 22:07:13 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 22:07:13 INFO - building 'psutil._psutil_posix' extension 22:07:13 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 22:07:13 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 22:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:13 INFO - Successfully installed psutil 22:07:13 INFO - Cleaning up... 22:07:13 INFO - Return code: 0 22:07:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:07:13 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')]} 22:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:13 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')]} 22:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:13 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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:13 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 22:07:13 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 22:07:13 INFO - Using env: {'DISPLAY': ':0', 22:07:13 INFO - 'HOME': '/home/cltbld', 22:07:13 INFO - 'LANG': 'en_US.UTF-8', 22:07:13 INFO - 'LANGUAGE': 'en_US:en', 22:07:13 INFO - 'LOGNAME': 'cltbld', 22:07:13 INFO - 'MAIL': '/var/mail/cltbld', 22:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:13 INFO - 'MOZ_NO_REMOTE': '1', 22:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:13 INFO - 'NO_EM_RESTART': '1', 22:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:13 INFO - 'SHELL': '/bin/bash', 22:07:13 INFO - 'SHLVL': '1', 22:07:13 INFO - 'TERM': 'linux', 22:07:13 INFO - 'TMOUT': '86400', 22:07:13 INFO - 'USER': 'cltbld', 22:07:13 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:13 INFO - '_': '/tools/buildbot/bin/python'} 22:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:15 INFO - Installing collected packages: mozsystemmonitor 22:07:15 INFO - Running setup.py install for mozsystemmonitor 22:07:15 INFO - Successfully installed mozsystemmonitor 22:07:15 INFO - Cleaning up... 22:07:15 INFO - Return code: 0 22:07:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:07:15 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')]} 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:15 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')]} 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:15 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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:15 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 22:07:15 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 22:07:15 INFO - Using env: {'DISPLAY': ':0', 22:07:15 INFO - 'HOME': '/home/cltbld', 22:07:15 INFO - 'LANG': 'en_US.UTF-8', 22:07:15 INFO - 'LANGUAGE': 'en_US:en', 22:07:15 INFO - 'LOGNAME': 'cltbld', 22:07:15 INFO - 'MAIL': '/var/mail/cltbld', 22:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:15 INFO - 'MOZ_NO_REMOTE': '1', 22:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:15 INFO - 'NO_EM_RESTART': '1', 22:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:15 INFO - 'SHELL': '/bin/bash', 22:07:15 INFO - 'SHLVL': '1', 22:07:15 INFO - 'TERM': 'linux', 22:07:15 INFO - 'TMOUT': '86400', 22:07:15 INFO - 'USER': 'cltbld', 22:07:15 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:15 INFO - '_': '/tools/buildbot/bin/python'} 22:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:16 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:18 INFO - Downloading docopt-0.6.1.tar.gz 22:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:18 INFO - Running setup.py install for blobuploader 22:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:07:18 INFO - Running setup.py install for requests 22:07:18 INFO - Running setup.py install for docopt 22:07:18 INFO - Successfully installed blobuploader requests docopt 22:07:18 INFO - Cleaning up... 22:07:19 INFO - Return code: 0 22:07:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:19 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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:19 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 22:07:19 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 22:07:19 INFO - Using env: {'DISPLAY': ':0', 22:07:19 INFO - 'HOME': '/home/cltbld', 22:07:19 INFO - 'LANG': 'en_US.UTF-8', 22:07:19 INFO - 'LANGUAGE': 'en_US:en', 22:07:19 INFO - 'LOGNAME': 'cltbld', 22:07:19 INFO - 'MAIL': '/var/mail/cltbld', 22:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:19 INFO - 'MOZ_NO_REMOTE': '1', 22:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:19 INFO - 'NO_EM_RESTART': '1', 22:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:19 INFO - 'SHELL': '/bin/bash', 22:07:19 INFO - 'SHLVL': '1', 22:07:19 INFO - 'TERM': 'linux', 22:07:19 INFO - 'TMOUT': '86400', 22:07:19 INFO - 'USER': 'cltbld', 22:07:19 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:19 INFO - '_': '/tools/buildbot/bin/python'} 22:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:19 INFO - Running setup.py (path:/tmp/pip-vm0xLm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:19 INFO - Running setup.py (path:/tmp/pip-DvXPQL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:19 INFO - Running setup.py (path:/tmp/pip-cd7I4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:19 INFO - Running setup.py (path:/tmp/pip-3ts8rT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:19 INFO - Running setup.py (path:/tmp/pip-0xw56F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:19 INFO - Running setup.py (path:/tmp/pip-13825H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:19 INFO - Running setup.py (path:/tmp/pip-3_r7Cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:19 INFO - Running setup.py (path:/tmp/pip-Y3xvrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:19 INFO - Running setup.py (path:/tmp/pip-cphfKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:19 INFO - Running setup.py (path:/tmp/pip-XrKLt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:19 INFO - Running setup.py (path:/tmp/pip-VD5S8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:20 INFO - Running setup.py (path:/tmp/pip-Hf3Bhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:20 INFO - Running setup.py (path:/tmp/pip-yxFU_S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:20 INFO - Running setup.py (path:/tmp/pip-K5cnbI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:20 INFO - Running setup.py (path:/tmp/pip-9C3QoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:20 INFO - Running setup.py (path:/tmp/pip-nWEvVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:20 INFO - Running setup.py (path:/tmp/pip-KQOhTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:20 INFO - Running setup.py install for manifestparser 22:07:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:07:20 INFO - Running setup.py install for mozcrash 22:07:20 INFO - Running setup.py install for mozdebug 22:07:20 INFO - Running setup.py install for mozdevice 22:07:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:07:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:07:20 INFO - Running setup.py install for mozfile 22:07:20 INFO - Running setup.py install for mozhttpd 22:07:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozinfo 22:07:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozInstall 22:07:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozleak 22:07:21 INFO - Running setup.py install for mozlog 22:07:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for moznetwork 22:07:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozprocess 22:07:21 INFO - Running setup.py install for mozprofile 22:07:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozrunner 22:07:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:07:21 INFO - Running setup.py install for mozscreenshot 22:07:22 INFO - Running setup.py install for moztest 22:07:22 INFO - Running setup.py install for mozversion 22:07:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:07:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:22 INFO - Cleaning up... 22:07:22 INFO - Return code: 0 22:07:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:22 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 22:07:22 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 22:07:22 INFO - Using env: {'DISPLAY': ':0', 22:07:22 INFO - 'HOME': '/home/cltbld', 22:07:22 INFO - 'LANG': 'en_US.UTF-8', 22:07:22 INFO - 'LANGUAGE': 'en_US:en', 22:07:22 INFO - 'LOGNAME': 'cltbld', 22:07:22 INFO - 'MAIL': '/var/mail/cltbld', 22:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:22 INFO - 'MOZ_NO_REMOTE': '1', 22:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:22 INFO - 'NO_EM_RESTART': '1', 22:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:22 INFO - 'SHELL': '/bin/bash', 22:07:22 INFO - 'SHLVL': '1', 22:07:22 INFO - 'TERM': 'linux', 22:07:22 INFO - 'TMOUT': '86400', 22:07:22 INFO - 'USER': 'cltbld', 22:07:22 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:22 INFO - '_': '/tools/buildbot/bin/python'} 22:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:22 INFO - Running setup.py (path:/tmp/pip-FOa_54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:22 INFO - Running setup.py (path:/tmp/pip-F6P9az-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:22 INFO - Running setup.py (path:/tmp/pip-z4ons7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:22 INFO - Running setup.py (path:/tmp/pip-foShoq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:22 INFO - Running setup.py (path:/tmp/pip-uLThEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:22 INFO - Running setup.py (path:/tmp/pip-VlBWwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:22 INFO - Running setup.py (path:/tmp/pip-Ew09cb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:22 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)) 22:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:22 INFO - Running setup.py (path:/tmp/pip-_lU6FV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:23 INFO - Running setup.py (path:/tmp/pip-tU6WKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:23 INFO - Running setup.py (path:/tmp/pip-Z7KuYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:23 INFO - Running setup.py (path:/tmp/pip-bBu875-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:23 INFO - Running setup.py (path:/tmp/pip-lIivnJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:23 INFO - Running setup.py (path:/tmp/pip-p51h87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:23 INFO - Running setup.py (path:/tmp/pip-m1DMXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:23 INFO - Running setup.py (path:/tmp/pip-ISQfjn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:23 INFO - Running setup.py (path:/tmp/pip-oBlrdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:23 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)) 22:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:23 INFO - Running setup.py (path:/tmp/pip-bBfN2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:23 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)) 22:07:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:25 INFO - Downloading blessings-1.5.1.tar.gz 22:07:25 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 22:07:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:25 INFO - Installing collected packages: blessings 22:07:25 INFO - Running setup.py install for blessings 22:07:25 INFO - Successfully installed blessings 22:07:25 INFO - Cleaning up... 22:07:25 INFO - Return code: 0 22:07:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:07:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:25 INFO - Reading from file tmpfile_stdout 22:07:25 INFO - Current package versions: 22:07:25 INFO - argparse == 1.2.1 22:07:25 INFO - blessings == 1.5.1 22:07:25 INFO - blobuploader == 1.2.4 22:07:25 INFO - docopt == 0.6.1 22:07:25 INFO - manifestparser == 1.1 22:07:25 INFO - mozInstall == 1.12 22:07:25 INFO - mozcrash == 0.16 22:07:25 INFO - mozdebug == 0.1 22:07:25 INFO - mozdevice == 0.47 22:07:25 INFO - mozfile == 1.2 22:07:25 INFO - mozhttpd == 0.7 22:07:25 INFO - mozinfo == 0.9 22:07:25 INFO - mozleak == 0.1 22:07:25 INFO - mozlog == 3.0 22:07:25 INFO - moznetwork == 0.27 22:07:25 INFO - mozprocess == 0.22 22:07:25 INFO - mozprofile == 0.27 22:07:25 INFO - mozrunner == 6.11 22:07:25 INFO - mozscreenshot == 0.1 22:07:25 INFO - mozsystemmonitor == 0.0 22:07:25 INFO - moztest == 0.7 22:07:25 INFO - mozversion == 1.4 22:07:25 INFO - psutil == 3.1.1 22:07:25 INFO - requests == 1.2.3 22:07:25 INFO - wsgiref == 0.1.2 22:07:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07: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')]} 22:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 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 0x7fd0d45f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, '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': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', '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 22:07:25 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 22:07:25 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 22:07:25 INFO - Using env: {'DISPLAY': ':0', 22:07:25 INFO - 'HOME': '/home/cltbld', 22:07:25 INFO - 'LANG': 'en_US.UTF-8', 22:07:25 INFO - 'LANGUAGE': 'en_US:en', 22:07:25 INFO - 'LOGNAME': 'cltbld', 22:07:25 INFO - 'MAIL': '/var/mail/cltbld', 22:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:25 INFO - 'MOZ_NO_REMOTE': '1', 22:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:25 INFO - 'NO_EM_RESTART': '1', 22:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:25 INFO - 'SHELL': '/bin/bash', 22:07:25 INFO - 'SHLVL': '1', 22:07:25 INFO - 'TERM': 'linux', 22:07:25 INFO - 'TMOUT': '86400', 22:07:25 INFO - 'USER': 'cltbld', 22:07:25 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:25 INFO - '_': '/tools/buildbot/bin/python'} 22:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 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)) 22:07:26 INFO - Cleaning up... 22:07:26 INFO - Return code: 0 22:07:26 INFO - Running post-action listener: _resource_record_post_action 22:07:26 INFO - Running post-action listener: _start_resource_monitoring 22:07:26 INFO - Starting resource monitoring. 22:07:26 INFO - ##### 22:07:26 INFO - ##### Running install step. 22:07:26 INFO - ##### 22:07:26 INFO - Running pre-action listener: _resource_record_pre_action 22:07:26 INFO - Running main action method: install 22:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Output received: 22:07:26 INFO - Usage: mozinstall [options] installer 22:07:26 INFO - Options: 22:07:26 INFO - -h, --help show this help message and exit 22:07:26 INFO - -d DEST, --destination=DEST 22:07:26 INFO - Directory to install application into. [default: 22:07:26 INFO - "/builds/slave/test-pgo"] 22:07:26 INFO - --app=APP Application being installed. [default: firefox] 22:07:26 INFO - mkdir: /builds/slave/test-pgo/build/application 22:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:07:40 INFO - Reading from file tmpfile_stdout 22:07:40 INFO - Output received: 22:07:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:07:40 INFO - Running post-action listener: _resource_record_post_action 22:07:40 INFO - ##### 22:07:40 INFO - ##### Running run-tests step. 22:07:40 INFO - ##### 22:07:40 INFO - Running pre-action listener: _resource_record_pre_action 22:07:40 INFO - Running main action method: run_tests 22:07:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:07:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:07:40 INFO - Python 2.7.3 22:07:40 INFO - Return code: 0 22:07:40 INFO - grabbing minidump binary from tooltool 22:07:40 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')]} 22:07:40 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 0x28788c0>, '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 0x2825420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28258b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:07:40 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 22:07:40 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 22:07:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:40 INFO - Return code: 0 22:07:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:07:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:07:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:07:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:07:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 22:07:40 INFO - Using env: {'DISPLAY': ':0', 22:07:40 INFO - 'HOME': '/home/cltbld', 22:07:40 INFO - 'LANG': 'en_US.UTF-8', 22:07:40 INFO - 'LANGUAGE': 'en_US:en', 22:07:40 INFO - 'LOGNAME': 'cltbld', 22:07:40 INFO - 'MAIL': '/var/mail/cltbld', 22:07:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:40 INFO - 'MOZ_NO_REMOTE': '1', 22:07:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:40 INFO - 'NO_EM_RESTART': '1', 22:07:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:07:40 INFO - 'SHELL': '/bin/bash', 22:07:40 INFO - 'SHLVL': '1', 22:07:40 INFO - 'TERM': 'linux', 22:07:40 INFO - 'TMOUT': '86400', 22:07:40 INFO - 'USER': 'cltbld', 22:07:40 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259', 22:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:40 INFO - '_': '/tools/buildbot/bin/python'} 22:07:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 22:07:41 INFO - mozversion INFO | application_buildid: 20151112203045 22:07:41 INFO - mozversion INFO | application_changeset: 4b2ec935bc99bc505776190210b11dfe552bd041 22:07:41 INFO - mozversion INFO | application_display_name: Nightly 22:07:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:41 INFO - mozversion INFO | application_name: Firefox 22:07:41 INFO - mozversion INFO | application_remotingname: firefox 22:07:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:07:41 INFO - mozversion INFO | application_vendor: Mozilla 22:07:41 INFO - mozversion INFO | application_version: 45.0a1 22:07:41 INFO - mozversion INFO | platform_buildid: 20151112203045 22:07:41 INFO - mozversion INFO | platform_changeset: 4b2ec935bc99bc505776190210b11dfe552bd041 22:07:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:07:41 INFO - mozversion INFO | platform_version: 45.0a1 22:07:41 INFO - 2015-11-12 22:07:41,020 DEBUG : using testdate: 1447394861 22:07:41 INFO - 2015-11-12 22:07:41,020 DEBUG : actual date: 1447394861 22:07:41 INFO - 2015-11-12 22:07:41,028 INFO : starting webserver on 'localhost:47682' 22:07:41 INFO - 2015-11-12 22:07:41,029 INFO : Starting test suite talos-linux64-ix-067.e 22:07:41 INFO - 2015-11-12 22:07:41,029 INFO : Starting test dromaeo_css 22:07:41 INFO - 2015-11-12 22:07:41,029 DEBUG : operating with platform_type : linux_ 22:07:41 INFO - 2015-11-12 22:07:41,030 INFO : Initialising browser for dromaeo_css test... 22:07:41 INFO - 2015-11-12 22:07:41,046 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_mvy7g/profile http://localhost:47682/getInfo.html 22:07:45 INFO - 2015-11-12 22:07:45,942 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:07:45 INFO - 2015-11-12 22:07:45,943 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:07:45 INFO - 2015-11-12 22:07:45,943 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:07:45 INFO - 2015-11-12 22:07:45,943 DEBUG : BROWSER_OUTPUT: __metrics 22:07:46 INFO - 2015-11-12 22:07:46,971 INFO : Browser initialized. 22:07:46 INFO - 2015-11-12 22:07:46,971 INFO : Running cycle 1/1 for dromaeo_css test... 22:07:46 INFO - 2015-11-12 22:07:46,972 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_mvy7g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:07:58 INFO - 2015-11-12 22:07:58,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 141033472 22:07:58 INFO - 2015-11-12 22:07:58,744 DEBUG : BROWSER_OUTPUT: 22:08:48 INFO - 2015-11-12 22:08:48,373 DEBUG : BROWSER_OUTPUT: 1447394928371 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] 22:10:56 INFO - 2015-11-12 22:10:56,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47682/tests/dromaeo/cssquery-ext.html) 22:10:58 INFO - 2015-11-12 22:10:58,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 146251776 22:10:58 INFO - 2015-11-12 22:10:58,072 DEBUG : BROWSER_OUTPUT: 22:14:00 INFO - 2015-11-12 22:14:00,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-ext.html (next: http://localhost:47682/tests/dromaeo/cssquery-jquery.html) 22:14:00 INFO - 2015-11-12 22:14:00,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 140255232 22:14:00 INFO - 2015-11-12 22:14:00,643 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-12 22:17:02,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47682/tests/dromaeo/cssquery-mootools.html) 22:17:02 INFO - 2015-11-12 22:17:02,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 22:17:02 INFO - 2015-11-12 22:17:02,903 DEBUG : BROWSER_OUTPUT: 22:20:04 INFO - 2015-11-12 22:20:04,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47682/tests/dromaeo/cssquery-prototype.html) 22:20:05 INFO - 2015-11-12 22:20:05,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 139358208 22:20:05 INFO - 2015-11-12 22:20:05,163 DEBUG : BROWSER_OUTPUT: 22:23:07 INFO - 2015-11-12 22:23:07,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47682/tests/dromaeo/cssquery-yui.html) 22:23:08 INFO - 2015-11-12 22:23:08,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 139280384 22:23:08 INFO - 2015-11-12 22:23:08,039 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-yui.html (next: http://localhost:47682/tests/dromaeo/cssquery-dojo.html) 22:26:10 INFO - 2015-11-12 22:26:10,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 142852096 22:26:10 INFO - 2015-11-12 22:26:10,586 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3266.8366581670916;3289.24347400098;3294.6540613235625;3320.5683261176046;3341.983290083549;5363.597730170233;5458.9454105458935;5562.86092847679;5572.972135139324;5580.330360356753;5448.945510544893;5474;5515.917261241085;5551.500364967153;5566;4919.040787046536;5002.299678045077;5056.747162641872;5087.516685914832;5095.643304968654;5012.924806127911;5084.110280700881;5154.819581314636;5181.611379146579;5185.922211166836;4860.173770458995;4981.128302547076;4985.501449855022;5084.313617661605;5113.105206588851;4988.501149885019;5042.243663450475;5058.873528161788;5063.063333283354;5084.694918304914;5111.335526381584;5115.693058416507;5126.974365128188;5128.974355128238;5163.845084647466;5283.181106928432;5288.735563221823;5369.463053694639;5434.130539113723;5464.508194262496;6025.3372129065765;6037.547183961176;6046.062860256668;6054.697265136726;6077.3314935357075;6063.090536419529;6063.787767428163;6073.362296958844;6099.939000609981;6103;5485.890282194374;5534.114541673353;5559.388467268597;5624.100143976944;5678.943210567924;6049.3950604939155;6074.817755467343;6081.361457046946;6086.330503644595;6118.449339559461;5648.548116150698;5824.621399609012;5827.650340979555;5833.270841144857;5864.296284445893;5756.683382413924;5926.822195334147;5953.910691339634;5955.67243801595;5957.225560677084;5935.614185077956;6010.278766548042;6041.214642096587;6067.7269522871575;6089.1779609753;5762.366139724627;5912.201852749909;6025.216721826222;6037.818865434044;6090.056041313604;4515.909681806345;4522.615577675869;4530.682852200381;4598.747068911242;4633.443986721615;4082.652974497201;4090.734102283342;4096.73371230869;4114.629683328515;4126.958730412657;5464.426235245322;5618.775248989995;5655.3779084300695;5672.801451949162;5691.146328050825;5852.502537284378;5925.525957923356;5957.4042595740075;5990.400959903975;6006.579539432285;5520.806771762969;5618.101103823368;5639.689817060101;5668.518175955008;5699.2590963174525;5042.672226305279;5140.485951404829;5180.792768289226;5182.97408512955;5208.453112423217;6103.155845961415;6165.1985241919165;6171.783987560414;6183.81448556544;6196.349383314777;5957.970210148921;5986.970065149646;5987.13186587951;6017.699115044143;6023.30731965812;6020.277566692025;6130.908036379547;6231.532635052298;6271.843203919939;6290.654014029089;5827.3007239131575;5829.7959571416495;5844.6493210405815;5894.351621321737;5911.615744976562;5970.044792833126;5980.760769569169;5989.221401217814;5993.280806303272;5993.490553303018;5656.85857853557;5757.0788673811985;5814.098814683731;5828.6502809831545;5931.258592675916;5822.621529600562;5839.357670656309;5847.210626565359;5849.3858144894175;5865.560082993878;5705;5741.712914354349;5742.7702891883855;5747.798827041033;5754.971225143848;5732.5413966881715;5813.069908814569;5837;5923.200367950444;5927.940720592911;5791.739371728198;5806.506446952057;5821.476067153976;5824.504917081926;5827.854303642443 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.1919676068084;593.8990371636821;600.8377738010737;601.5849064145742;602.7287720525763;39784.20431591367;40371.79814100929;40436;40476.79761601195;40662;41580.37629435561;42349;42394;42397.36403953935;42437.151256974845;8677.783055423602;8806.86789698155;8876.378653494257;8912.331575131859;8917.152870477294;8625.870611940825;8651.221390074892;8702.521361325125;8730.257928076122;8740;8561.272291855199;8690.304775617935;8721.60752766124;8743.95628021859;8745.169208925174;8660.220580147818;8666.826663466727;8751.256143227833;8755.299576033934;8783.47299162046;8543.95728021362;8668.566571671392;8692.695755648585;8700.042995270514;8709.25971292441;38969.80515097406;39478.60521394778;39573.60426395757;39592;40025.59974400277;3066.31008023193;3465.6707612776745;3997.920041599181;4001.279769641463;4109.116539943897;29205.123846284645;29623.851880740673;29775.404491910256;30419.69580304191;30478.84760576205;3301.4552598821165;3397.8640854365794;3415.0949998250485;3417.624061353249;3420.110771199506;270086;270791;270844;271222;271663;55733;57264;57442.13836792451;57842.4215757837;58871.70564147152;53655;53804.730976344865;53916;54014.18978715244;54307;13857.792133118011;13889.097208681404;13899.930500347433;13950.720985580232;14009.43962241499;10686.038256556947;10764.569417223223;10781.299215550964;10845.295055821347;10864.130869530418;19227.22862189939;19669.21323147058;19764.901175494317;19809.20763169486;19822.70265946012;7571.3564347030015;7698.538087714643;7798.961005194938;7802.726904558313;7808.180141085218;859.1623167411724;868.8827008353792;957.2533423929207;960.577345967786;1107.855978722761;28793.28016799555;28793.712062879524;28866.71133288682;29009.12972610825;29132.563011554845;1014.4978235773192;1022.5551884930079;1034.5603118674533;1111.2665640677114;1133.6485689436136;14882.479113230986;14948.252587370587;14977.326020329112;15157.166355850533;15210.847891521165;323279;325600;325614;326030;328289;52373.214401784004;52533.47466525362;52735.20897186545;53089.46910530845;53201.2019819703;1318.1168617026424;1354.5462270139615;1369.7945308203848;1379.6206043338161;1380.9930950345183;27749.167524974284;28465;28648.14055578336;28737;28851.7114828849;46782.76608616935;47111.528884710715;47326.29010564776;47346.28980565363;47364.2895356563;294601;295915;296250;296661;296905;28103.57844632373;28539.714602853706;31650.208744781565;32460.738211479027;34619.13452163615;41625.1674966505;41764;42087.789561052;42711.7864410676;42717;34881.30237395187;35462;36006.63993360033;36614;36849.26301474009;33764;35360.29279414449;35575.46636800502;36222.8188859054;36967.630323696416;33940.83029584836;34051.14872128217;36316.81841590775;36619;36862.262754745294;28588.42823143484;30145;31026.534601980537;31132.22169445782;32142;24918.50162996766;25197;25249.74750252474;25335;25437.745622544277 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.8242172859249;335.72638299785666;336.17133765268613;336.53558089836054;336.99494507582375;12454.190477618948;12703.364831758421;16277.104759238237;16428.589285267873;17440.47678569643;11460.770784584303;11484.425778711053;11503.252288601236;11572.479238434269;11822.290662560252;4447.666425018128;4564.041551274237;4570.268756998881;4579.496255411918;4585.72485650862;4468.240399132155;4607.216773148556;4609.884752881171;4614.238650622643;4614.46933602635;4554.954450455486;4575.26795712686;4631.235846085408;4763.214069678499;4768.308595253686;4737.644676649265;4739.383880095583;4742.027884283748;4742.075295317414;4762.238041913294;4052.6150015748754;4160.771157586331;4165.416841642173;4169.97915010423;4172.395002724588;13342.865856402217;13436.596902092855;13511.459541618324;13609.183448993092;13734.793978090336;1817.2458429751637;1830.6979348407497;1843.6497065557635;1845.704687250047;1995.1321175288651;9395.906040939572;9490.90509094907;9543.856842147305;9687.564059617334;9754.512274386252;1737.574294297905;1739.5216315513208;1761.9076172772834;1783.0460703523552;1817.572870375474;57654;59625;60232.69883650597;60464;60506.69746651283;6568.96715516429;6638.966805165944;6653.434458071021;6690.765823196262;6714.563553369016;7755.3407960324;7771.10632277284;7792.454528182972;7866.7639970800965;7867;4928.827491037797;4957.206846904478;4966.304717339575;5102.4897510248675;5159.432462429129;4722.244440889442;4781.2350023996;4788.952110478851;4910.680805747615;4975.651704380731;3082.2448500117166;3110.1913502489515;3113.719765221141;3126.3903538809714;3153.716165545112;1111.766529028897;1125.139268459629;1127.2165844737992;1133.812920868064;1168.4741866160261;339.61114523870526;339.96940275375334;341.54233327341484;341.9743519236067;370.13019404399444;9596;9970.152537034433;10024.699259022242;10093.747656308651;10206.183505319557;367.02554717225274;370.3481871905466;374.8275793135188;377.8927741716796;380.2679841305476;5385.9730701347025;5410.864728381822;5439.5104440600535;5523.116301391758;5533.142362933751;498488;498821;502020.87874726905;512740;517852;76665.23334766581;77722.6113869427;77780;77792.61103694445;79199;372.9347364211252;377.1175449448304;377.98488060477825;378.7840930669492;379.035355021471;9014.28728541575;9139.954300228455;9167.404118732527;9247.029061948668;9334.25325973934;33232.667673322954;34673.13317167091;34987.30025399529;35310.823445882605;35420.29159416746;47285.2907206399;47602.285965711235;47845;47859.521404785504;48189.27716084332;6309.936900631119;6446;6571.244306904576;6572.112764776885;6580.21037475506;11990;12144.696382590153;12187.329696866758;12281.93859030699;12426.5650702225;9448.669296574586;10112.191024718151;10545.841812372668;10563.788724225318;10604.310719803188;10396.376217426978;10404.531796069045;10466.215033872642;10512.106470950055;11008;10548.683539493828;10570.154387649123;10725.463726813472;10998.670039898816;11111.555537778722;6598.637074960923;6688.665566721742;6694.129763130762;6716.764913228014;6717.361850624183;10451.372917624967;10491.475426228812;10602.946985265333;10763.085137763377;11212.27120237182 22:26:10 INFO - 2015-11-12 22:26:10,587 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1505.7139143562729;1715.0910017690624;1764.5323989142871;1775.201159478235;1793.3006127610226;5881.059030555112;6026.276846778387;6071.908921366177;7272.418206543477;7472.402207823375;7354.521956072865;7371.926280737204;7379.446541509382;7407.8888816667795;7457.440691948112;1981.4650044488017;1999.9500012499732;2015.3450128708155;2016.7882372350912;2019.061136571494;2217.3126330837413;2228.944276393095;2247.820174386045;2267.965980510294;2268.9773102269014;2070.213318938801;2071.730675012246;2116.153538584563;2135.6155891939443;2147.0338347743577;2153.267888917768;2156.644153714635;2169.826413886893;2175.369142948551;2199.8350123740784;2217.2904670505445;2234.218023691711;2242.551489702066;2246.7977881990537;2255.436140964759;7124.536905101152;7224.1692205396;7231.602261875595;7243.384312333458;7255.854882902365;4402.801873915681;4481.7983190756495;4485.013297074638;4485.708428952108;4489.7979590918485;2752.5320695481814;2890.132960111979;2905.941881162365;2916.5916771651987;2935.530315149566;876.071364353787;899.8920129584426;910.2035718746097;946.5125460387906;948.672707915768;9542.570584323723;9687.51562421876;9718.222542196678;9721.31950763447;9746.805063898753;3733.309337772521;3853.614638536124;3898.3372826618975;3904.1801221743754;3920.4707364506;7913.723019694283;7969.565478213977;7999.480033797785;8008.719694810654;8010.158933312035;4342.5657434256955;4348.652107831366;4352.151330490524;4371.737695738266;4383.3863259143745;3963.801809909493;3972.682185425159;3972.880813575597;3975.4633124528395;4002.1195337025806;3216.5979252593424;3224.081136875979;3245.951310730341;3246.935061298761;3252.9674703253136;996.6212839121088;997.0229175408141;997.6109317366088;998.4758002048983;1007.1087087927237;975.9560819762986;980.0395612299986;1065.9573617055387;1092.6776600902595;1281.7564662714242;6112.7554897804475;6128.264608247039;6134.693265336716;6150.015997440388;6186.412290832363;1112.1380929779325;1113.582406597526;1123.4607388453426;1127.2898074213192;1171.1392126786805;5139.254808052811;5143.691378517301;5184.818531351385;5185.792568297225;5189.792408303626;8448.704295349757;8492.193241642035;8640.654373824977;8689.391742578086;8721;8428.704995325133;8504.489730616182;8539.658413663385;8551.700690475927;8569.885914831157;6751.054852320679;6806.285340039323;6810.774060669127;6837.555558888656;6847.452203823682;6238.906416403667;6242.687865606792;6266.905996409966;6289.874202515833;6308.653024083719;7520.511166774142;7524.322810946822;7634.50375725576;7672.810714339286;7798.883016754639;7725.845483090419;7787.649555769891;7862.646180921986;7865.921340786519;7926.445148839526;6244.906326405016;6261.530385221217;6332.873342533031;6341.55609107358;6350.047492876106;6992.61540615271;7020;7039.788806335818;7042.471814614027;7088.2202957675645;6267.310595834363;6483.351664833479;6489.545731798728;6557.868842623217;6646.8005959821285;6263.874722505433;6354.555181137276;6374.521910856612;6451.516136289703;6475.708593113415;5977.22296101504;6010.639361638316;6044.304904935989;6072.514198864169;6115.266168059861;5541.944580554143;5547.41752116022;5558.72206389687;5567.944320556905;5575.135853942646;5610.887782244414;5629.662220266797;5657.094864821609;5665.5750818689585;5666.801661941812 22:26:10 INFO - 2015-11-12 22:26:10,589 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.25748025213426;293.4629627781162;294.1645726137769;300.44567772459806;300.50716824407976;6167.845803854901;6289.710609325089;6295.842603934898;6309.179806625144;6423.389777971085;6291.402316779899;6307.3692630736905;6307.810765677025;6333.145025421567;6346.301906790261;4707.270373092176;4712.316714076457;4713.057388522292;4717.858464246061;4735.218688916325;4712.034033023239;4716.245400735883;4716.669833111683;4716.9292460613115;4723.5512626300615;4583.175028494869;4671.439427268732;4693.859184224479;4695.131400690883;4698.436187657486;4661.463931647853;4688.179568575486;4688.249880019198;4690.976545117287;4702.576768090888;4004.439378487014;4007.1184339445276;4007.7595344279434;4013.2776100301935;4014.7992600369867;5929.080992446177;5951.613145145551;5954.761809527614;5983.222181116471;6001.06983417571;5311.517051825257;5374.220737993008;5445.264889239941;5448.782048718046;5450.427705090948;6673.432758215557;6685.732570697215;6686.297938716462;6690.063391125246;6691.464682825363;4400.44994375703;4437.0682156747125;4440.733555986619;4443.466783985942;4446.799894004777;6626.668666566652;6786.966065169692;6874;6951.339622735832;6969.965150174267;4371.278739008092;4383.452068491439;4387.912241755211;4389.385486031958;4395.077033822933;4438.578335058164;4439.067795762861;4440.955590444119;4446.355278484666;4446.9555304447185;5241.659292145999;5286.444923283;5286.550643195372;5289.550388216968;5297.073012222922;6538.280789113289;6669.699863506154;6709.563878347989;6736.46108311334;6743.2919543448215;1584.8335924727737;1588.8172860121003;1591.3952697974696;1592.3471376735483;1600.1119378744909;1067.412922892406;1070.2936062199067;1076.424113099488;1081.6052140968648;1087.9401632910267;6346.8413289667205;6354.3963323484195;6360.872782544323;6370.267419246753;6384.7126879290545;6772.255051944282;6794.422474089758;6802.217744959393;6829.965850170717;6843.8973415398805;6210.254769427607;6312.8421789454715;6346;6361.109444677749;6377.904331435032;3715.238376132886;3723.8138093095235;3731.048582611417;3739.3456145174487;3745.194783121642;7063.611501367372;7127.786166415016;7128.932609543278;7136.215016348197;7173.282671732889;6978.476614253951;6995.475339349569;7009.2990700929495;7014.964925175444;7020.403265722369;7307;7348.485606007635;7360.0431943848025;7369.520981136209;7377.704891804375;6994.650267486707;7006.719731210898;7012.544184627983;7019.5788252705;7020.22777494465;6821.249662537216;6915.377616014583;6929.064576282339;6934.375906168469;6944.826379340557;7286.234945330876;7328.890066649111;7337.633118344168;7338.633068346669;7350.70597176107;4488.573585509372;4532.70537415067;4535.7958891849285;4537.8184872604725;4540.409746732904;6861.382475577222;6921.307869213038;6945.166580010431;6963;6979.092717946837;6758.831029224309;6765.391114799691;6771.39057484809;6775.457963363017;6776.525643205126;6688.264290927897;6757.020232066225;6761.695723692347;6764.695588698422;6767.424768894699;6431.742730290923;6590.670466476753;6596.109525214035;6597.0764093026055;6612.537122401386;6760.661966901734;6767.661616919036;6785.9660701696175;6789.321067893368;6801.18385793708;6615.305392933673;6633.1045308882685;6640.734370625121;6642.83392915181;6643.169603799525 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: |5;yui.html;660.3000819131721;759.161126954715;760.2853317881192;762.5462849604484;778.6729573579096;14091.929540352297;14551.708965820677;14561;14626.634334141638;14652.560423187308;12233.877661223385;12830.486780528767;12848.74302513949;12895.742085158292;12923.966082713383;817.5217497763815;829.3531045784267;830.9252167304942;832.3840358134997;833.5665453963935;828.2297463359074;836.0510820219065;836.636063312458;837.0123254559617;839.2740279658112;875.3259989807876;875.6366108065146;885.8272636835819;889.9911000890005;890.568074483878;874.0909454167657;877.7981064355203;882.4881568690176;883.4037025008093;887.5029983209423;646.4860435953382;653.3694984340135;653.9084528166061;655.1352215076101;656.3338211715113;12879.905208057233;12971.935140324238;12993.545225917142;13037.15258508194;13115.606531804062;11872.465739041763;11920;12082.33547154906;12364.319962402064;12366.072544559103;9745.220382369464;9791.216702663769;9886.653967111117;9958.452285124315;10091.2431567632;3583.4266517357096;3622.1669016126175;3654.086478380405;3661.1030297577;3740.1397678533817;47883.76058119687;48480.27279590809;48597;48696.269555956686;49068.99999999964;8887.111288871061;9126.498042607587;9146.359754817233;9210.401323914059;9515.666951656658;18620.16209270586;18776.155073021746;18809.43571692824;18819.059047047595;18894.149763260688;7447.478676492594;7499.812504687427;7596.544207347577;7618.771436856903;7707;4117.794110294473;4191.036061705825;4192.664586833046;4198.8110535026;4221.704480686384;3000.6099207103375;3014.8794048237824;3026.757859371245;3028.4851575231824;3031.3028003559307;436.5765207748479;438.07566035664723;443.72489056785;451.41316288824396;452.93206019097397;505.92664063711294;561.2675458526662;632.2634131237149;673.4545018535002;680.1939701453794;8361.916380836235;8370.414071014971;8646.394752367274;8723.956380218058;8818.470891746516;582.8805094955524;609.9512039036866;614.8616561273767;677.3091446724313;708.3200127877193;4079.592040795956;4150.252954468225;4196.622303992655;4223.852165174204;4251.213525497793;52762.47237527652;58503;58649;59367.703161483914;60542.697286513285;43320.13359732851;44222.33666495005;45001.324980125326;47694.28458573124;47799.283010754865;44828.3275750864;45995;46300;46781;47351.05297894023;8217.54803485814;8449.45078569891;8757.124287571192;8776.297896168164;8831.072737362485;35264.47103293504;35424;35472.113197169245;35939.46090808588;36053.45919811152;39979;40570.94290570919;43585.346219806095;44038.55961440344;44446.555534445535;7287;7301.269873012656;7314;7333.552900785444;7387;11601.446827116124;11612.303261804318;11665.59170429031;11888.940555297168;12111.878881211074;11240.325580465198;11282.717932051764;11629.709257268636;11728.882711172779;12109.636710898687;11351.602693905674;11527.538898444303;11574.594889178838;11784.351860647746;11921.642350729491;10966.616168434066;11199.272047316897;11277.379744114152;11311.547538098384;11651.47568359409;9155.496447695441;9256.25949924018;9258.53707314645;9298.302627302844;9788.559514821993;8406.915930840858;8615.6984505542;9010.189082982562;9200.26397888154;9320.254379649747 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,280 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: __startTimestamp1447395970581__endTimestamp 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:26:10 INFO - 2015-11-12 22:26:10,590 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:26:10 INFO - 2015-11-12 22:26:10,591 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,591 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5538.35 Median:5754.97 stddev:624.56 (10.9%) stddev-sans-first:600.52 22:26:10 INFO - 2015-11-12 22:26:10,591 DEBUG : BROWSER_OUTPUT: Values: 3266.8 3289.2 3294.7 3320.6 3342.0 5363.6 5458.9 5562.9 5573.0 5580.3 5448.9 5474.0 5515.9 5551.5 5566.0 4919.0 5002.3 5056.7 5087.5 5095.6 5012.9 5084.1 5154.8 5181.6 5185.9 4860.2 4981.1 4985.5 5084.3 5113.1 4988.5 5042.2 5058.9 5063.1 5084.7 5111.3 5115.7 5127.0 5129.0 5163.8 5283.2 5288.7 5369.5 5434.1 5464.5 6025.3 6037.5 6046.1 6054.7 6077.3 6063.1 6063.8 6073.4 6099.9 6103.0 5485.9 5534.1 5559.4 5624.1 5678.9 6049.4 6074.8 6081.4 6086.3 6118.4 5648.5 5824.6 5827.7 5833.3 5864.3 5756.7 5926.8 5953.9 5955.7 5957.2 5935.6 6010.3 6041.2 6067.7 6089.2 5762.4 5912.2 6025.2 6037.8 6090.1 4515.9 4522.6 4530.7 4598.7 4633.4 4082.7 4090.7 4096.7 4114.6 4127.0 5464.4 5618.8 5655.4 5672.8 5691.1 5852.5 5925.5 5957.4 5990.4 6006.6 5520.8 5618.1 5639.7 5668.5 5699.3 5042.7 5140.5 5180.8 5183.0 5208.5 6103.2 6165.2 6171.8 6183.8 6196.3 5958.0 5987.0 5987.1 6017.7 6023.3 6020.3 6130.9 6231.5 6271.8 6290.7 5827.3 5829.8 5844.6 5894.4 5911.6 5970.0 5980.8 5989.2 5993.3 5993.5 5656.9 5757.1 5814.1 5828.7 5931.3 5822.6 5839.4 5847.2 5849.4 5865.6 5705.0 5741.7 5742.8 5747.8 5755.0 5732.5 5813.1 5837.0 5923.2 5927.9 5791.7 5806.5 5821.5 5824.5 5827.9 22:26:10 INFO - 2015-11-12 22:26:10,591 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,591 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46431.34 Median:36114.73 stddev:78007.79 (216.0%) stddev-sans-first:78150.59 22:26:10 INFO - 2015-11-12 22:26:10,592 DEBUG : BROWSER_OUTPUT: Values: 559.2 593.9 600.8 601.6 602.7 39784.2 40371.8 40436.0 40476.8 40662.0 41580.4 42349.0 42394.0 42397.4 42437.2 8677.8 8806.9 8876.4 8912.3 8917.2 8625.9 8651.2 8702.5 8730.3 8740.0 8561.3 8690.3 8721.6 8744.0 8745.2 8660.2 8666.8 8751.3 8755.3 8783.5 8544.0 8668.6 8692.7 8700.0 8709.3 38969.8 39478.6 39573.6 39592.0 40025.6 3066.3 3465.7 3997.9 4001.3 4109.1 29205.1 29623.9 29775.4 30419.7 30478.8 3301.5 3397.9 3415.1 3417.6 3420.1 270086.0 270791.0 270844.0 271222.0 271663.0 55733.0 57264.0 57442.1 57842.4 58871.7 53655.0 53804.7 53916.0 54014.2 54307.0 13857.8 13889.1 13899.9 13950.7 14009.4 10686.0 10764.6 10781.3 10845.3 10864.1 19227.2 19669.2 19764.9 19809.2 19822.7 7571.4 7698.5 7799.0 7802.7 7808.2 859.2 868.9 957.3 960.6 1107.9 28793.3 28793.7 28866.7 29009.1 29132.6 1014.5 1022.6 1034.6 1111.3 1133.6 14882.5 14948.3 14977.3 15157.2 15210.8 323279.0 325600.0 325614.0 326030.0 328289.0 52373.2 52533.5 52735.2 53089.5 53201.2 1318.1 1354.5 1369.8 1379.6 1381.0 27749.2 28465.0 28648.1 28737.0 28851.7 46782.8 47111.5 47326.3 47346.3 47364.3 294601.0 295915.0 296250.0 296661.0 296905.0 28103.6 28539.7 31650.2 32460.7 34619.1 41625.2 41764.0 42087.8 42711.8 42717.0 34881.3 35462.0 36006.6 36614.0 36849.3 33764.0 35360.3 35575.5 36222.8 36967.6 33940.8 34051.1 36316.8 36619.0 36862.3 28588.4 30145.0 31026.5 31132.2 32142.0 24918.5 25197.0 25249.7 25335.0 25437.7 22:26:10 INFO - 2015-11-12 22:26:10,592 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,592 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25676.55 Median:4171.19 stddev:83108.38 (1992.4%) stddev-sans-first:83319.73 22:26:10 INFO - 2015-11-12 22:26:10,592 DEBUG : BROWSER_OUTPUT: Values: 334.8 335.7 336.2 336.5 337.0 12454.2 12703.4 16277.1 16428.6 17440.5 11460.8 11484.4 11503.3 11572.5 11822.3 4447.7 4564.0 4570.3 4579.5 4585.7 4468.2 4607.2 4609.9 4614.2 4614.5 4555.0 4575.3 4631.2 4763.2 4768.3 4737.6 4739.4 4742.0 4742.1 4762.2 4052.6 4160.8 4165.4 4170.0 4172.4 13342.9 13436.6 13511.5 13609.2 13734.8 1817.2 1830.7 1843.6 1845.7 1995.1 9395.9 9490.9 9543.9 9687.6 9754.5 1737.6 1739.5 1761.9 1783.0 1817.6 57654.0 59625.0 60232.7 60464.0 60506.7 6569.0 6639.0 6653.4 6690.8 6714.6 7755.3 7771.1 7792.5 7866.8 7867.0 4928.8 4957.2 4966.3 5102.5 5159.4 4722.2 4781.2 4789.0 4910.7 4975.7 3082.2 3110.2 3113.7 3126.4 3153.7 1111.8 1125.1 1127.2 1133.8 1168.5 339.6 340.0 341.5 342.0 370.1 9596.0 9970.2 10024.7 10093.7 10206.2 367.0 370.3 374.8 377.9 380.3 5386.0 5410.9 5439.5 5523.1 5533.1 498488.0 498821.0 502020.9 512740.0 517852.0 76665.2 77722.6 77780.0 77792.6 79199.0 372.9 377.1 378.0 378.8 379.0 9014.3 9140.0 9167.4 9247.0 9334.3 33232.7 34673.1 34987.3 35310.8 35420.3 47285.3 47602.3 47845.0 47859.5 48189.3 6309.9 6446.0 6571.2 6572.1 6580.2 11990.0 12144.7 12187.3 12281.9 12426.6 9448.7 10112.2 10545.8 10563.8 10604.3 10396.4 10404.5 10466.2 10512.1 11008.0 10548.7 10570.2 10725.5 10998.7 11111.6 6598.6 6688.7 6694.1 6716.8 6717.4 10451.4 10491.5 10602.9 10763.1 11212.3 22:26:10 INFO - 2015-11-12 22:26:10,592 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,592 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4962.41 Median:6092.63 stddev:2521.93 (41.4%) stddev-sans-first:2515.62 22:26:10 INFO - 2015-11-12 22:26:10,593 DEBUG : BROWSER_OUTPUT: Values: 1505.7 1715.1 1764.5 1775.2 1793.3 5881.1 6026.3 6071.9 7272.4 7472.4 7354.5 7371.9 7379.4 7407.9 7457.4 1981.5 2000.0 2015.3 2016.8 2019.1 2217.3 2228.9 2247.8 2268.0 2269.0 2070.2 2071.7 2116.2 2135.6 2147.0 2153.3 2156.6 2169.8 2175.4 2199.8 2217.3 2234.2 2242.6 2246.8 2255.4 7124.5 7224.2 7231.6 7243.4 7255.9 4402.8 4481.8 4485.0 4485.7 4489.8 2752.5 2890.1 2905.9 2916.6 2935.5 876.1 899.9 910.2 946.5 948.7 9542.6 9687.5 9718.2 9721.3 9746.8 3733.3 3853.6 3898.3 3904.2 3920.5 7913.7 7969.6 7999.5 8008.7 8010.2 4342.6 4348.7 4352.2 4371.7 4383.4 3963.8 3972.7 3972.9 3975.5 4002.1 3216.6 3224.1 3246.0 3246.9 3253.0 996.6 997.0 997.6 998.5 1007.1 976.0 980.0 1066.0 1092.7 1281.8 6112.8 6128.3 6134.7 6150.0 6186.4 1112.1 1113.6 1123.5 1127.3 1171.1 5139.3 5143.7 5184.8 5185.8 5189.8 8448.7 8492.2 8640.7 8689.4 8721.0 8428.7 8504.5 8539.7 8551.7 8569.9 6751.1 6806.3 6810.8 6837.6 6847.5 6238.9 6242.7 6266.9 6289.9 6308.7 7520.5 7524.3 7634.5 7672.8 7798.9 7725.8 7787.6 7862.6 7865.9 7926.4 6244.9 6261.5 6332.9 6341.6 6350.0 6992.6 7020.0 7039.8 7042.5 7088.2 6267.3 6483.4 6489.5 6557.9 6646.8 6263.9 6354.6 6374.5 6451.5 6475.7 5977.2 6010.6 6044.3 6072.5 6115.3 5541.9 5547.4 5558.7 5567.9 5575.1 5610.9 5629.7 5657.1 5665.6 5666.8 22:26:10 INFO - 2015-11-12 22:26:10,593 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,593 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5539.12 Median:6346.15 stddev:1743.78 (27.5%) stddev-sans-first:1703.43 22:26:10 INFO - 2015-11-12 22:26:10,594 DEBUG : BROWSER_OUTPUT: Values: 281.3 293.5 294.2 300.4 300.5 6167.8 6289.7 6295.8 6309.2 6423.4 6291.4 6307.4 6307.8 6333.1 6346.3 4707.3 4712.3 4713.1 4717.9 4735.2 4712.0 4716.2 4716.7 4716.9 4723.6 4583.2 4671.4 4693.9 4695.1 4698.4 4661.5 4688.2 4688.2 4691.0 4702.6 4004.4 4007.1 4007.8 4013.3 4014.8 5929.1 5951.6 5954.8 5983.2 6001.1 5311.5 5374.2 5445.3 5448.8 5450.4 6673.4 6685.7 6686.3 6690.1 6691.5 4400.4 4437.1 4440.7 4443.5 4446.8 6626.7 6787.0 6874.0 6951.3 6970.0 4371.3 4383.5 4387.9 4389.4 4395.1 4438.6 4439.1 4441.0 4446.4 4447.0 5241.7 5286.4 5286.6 5289.6 5297.1 6538.3 6669.7 6709.6 6736.5 6743.3 1584.8 1588.8 1591.4 1592.3 1600.1 1067.4 1070.3 1076.4 1081.6 1087.9 6346.8 6354.4 6360.9 6370.3 6384.7 6772.3 6794.4 6802.2 6830.0 6843.9 6210.3 6312.8 6346.0 6361.1 6377.9 3715.2 3723.8 3731.0 3739.3 3745.2 7063.6 7127.8 7128.9 7136.2 7173.3 6978.5 6995.5 7009.3 7015.0 7020.4 7307.0 7348.5 7360.0 7369.5 7377.7 6994.7 7006.7 7012.5 7019.6 7020.2 6821.2 6915.4 6929.1 6934.4 6944.8 7286.2 7328.9 7337.6 7338.6 7350.7 4488.6 4532.7 4535.8 4537.8 4540.4 6861.4 6921.3 6945.2 6963.0 6979.1 6758.8 6765.4 6771.4 6775.5 6776.5 6688.3 6757.0 6761.7 6764.7 6767.4 6431.7 6590.7 6596.1 6597.1 6612.5 6760.7 6767.7 6786.0 6789.3 6801.2 6615.3 6633.1 6640.7 6642.8 6643.2 22:26:10 INFO - 2015-11-12 22:26:10,594 DEBUG : BROWSER_OUTPUT: 22:26:10 INFO - 2015-11-12 22:26:10,594 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13470.52 Median:47841.52 stddev:15628.61 (32.7%) stddev-sans-first:15642.85 22:26:10 INFO - 2015-11-12 22:26:10,594 DEBUG : BROWSER_OUTPUT: Values: 660.3 759.2 760.3 762.5 778.7 14091.9 14551.7 14561.0 14626.6 14652.6 12233.9 12830.5 12848.7 12895.7 12924.0 817.5 829.4 830.9 832.4 833.6 828.2 836.1 836.6 837.0 839.3 875.3 875.6 885.8 890.0 890.6 874.1 877.8 882.5 883.4 887.5 646.5 653.4 653.9 655.1 656.3 12879.9 12971.9 12993.5 13037.2 13115.6 11872.5 11920.0 12082.3 12364.3 12366.1 9745.2 9791.2 9886.7 9958.5 10091.2 3583.4 3622.2 3654.1 3661.1 3740.1 47883.8 48480.3 48597.0 48696.3 49069.0 8887.1 9126.5 9146.4 9210.4 9515.7 18620.2 18776.2 18809.4 18819.1 18894.1 7447.5 7499.8 7596.5 7618.8 7707.0 4117.8 4191.0 4192.7 4198.8 4221.7 3000.6 3014.9 3026.8 3028.5 3031.3 436.6 438.1 443.7 451.4 452.9 505.9 561.3 632.3 673.5 680.2 8361.9 8370.4 8646.4 8724.0 8818.5 582.9 610.0 614.9 677.3 708.3 4079.6 4150.3 4196.6 4223.9 4251.2 52762.5 58503.0 58649.0 59367.7 60542.7 43320.1 44222.3 45001.3 47694.3 47799.3 44828.3 45995.0 46300.0 46781.0 47351.1 8217.5 8449.5 8757.1 8776.3 8831.1 35264.5 35424.0 35472.1 35939.5 36053.5 39979.0 40570.9 43585.3 44038.6 44446.6 7287.0 7301.3 7314.0 7333.6 7387.0 11601.4 11612.3 11665.6 11888.9 12111.9 11240.3 11282.7 11629.7 11728.9 12109.6 11351.6 11527.5 11574.6 11784.4 11921.6 10966.6 11199.3 11277.4 11311.5 11651.5 9155.5 9256.3 9258.5 9298.3 9788.6 8406.9 8615.7 9010.2 9200.3 9320.3 22:26:10 INFO - 2015-11-12 22:26:10,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:26:10 INFO - 2015-11-12 22:26:10,594 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-12 22:26:11,199 INFO : Browser exited with error code: 0 22:26:11 INFO - 2015-11-12 22:26:11,218 INFO : Completed test dromaeo_css (00:18:30) 22:26:11 INFO - 2015-11-12 22:26:11,218 INFO : Starting test kraken 22:26:11 INFO - 2015-11-12 22:26:11,218 DEBUG : operating with platform_type : linux_ 22:26:11 INFO - 2015-11-12 22:26:11,218 INFO : Initialising browser for kraken test... 22:26:11 INFO - 2015-11-12 22:26:11,224 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_fT9kR/profile http://localhost:47682/getInfo.html 22:26:15 INFO - 2015-11-12 22:26:15,665 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:26:15 INFO - 2015-11-12 22:26:15,665 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:26:15 INFO - 2015-11-12 22:26:15,665 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:26:15 INFO - 2015-11-12 22:26:15,665 DEBUG : BROWSER_OUTPUT: __metrics 22:26:16 INFO - 2015-11-12 22:26:16,727 INFO : Browser initialized. 22:26:16 INFO - 2015-11-12 22:26:16,727 INFO : Running cycle 1/1 for kraken test... 22:26:16 INFO - 2015-11-12 22:26:16,728 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_fT9kR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:26:28 INFO - 2015-11-12 22:26:28,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 140038144 22:26:28 INFO - 2015-11-12 22:26:28,541 DEBUG : BROWSER_OUTPUT: 22:26:31 INFO - 2015-11-12 22:26:31,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:31 INFO - 2015-11-12 22:26:31,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 141619200 22:26:31 INFO - 2015-11-12 22:26:31,644 DEBUG : BROWSER_OUTPUT: 22:26:34 INFO - 2015-11-12 22:26:34,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-dft) 22:26:34 INFO - 2015-11-12 22:26:34,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 140939264 22:26:34 INFO - 2015-11-12 22:26:34,914 DEBUG : BROWSER_OUTPUT: 22:26:37 INFO - 2015-11-12 22:26:37,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-fft) 22:26:38 INFO - 2015-11-12 22:26:38,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 136318976 22:26:38 INFO - 2015-11-12 22:26:38,360 DEBUG : BROWSER_OUTPUT: 22:26:40 INFO - 2015-11-12 22:26:40,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-oscillator) 22:26:40 INFO - 2015-11-12 22:26:40,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 136720384 22:26:40 INFO - 2015-11-12 22:26:40,983 DEBUG : BROWSER_OUTPUT: 22:26:43 INFO - 2015-11-12 22:26:43,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:43 INFO - 2015-11-12 22:26:43,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 136626176 22:26:43 INFO - 2015-11-12 22:26:43,751 DEBUG : BROWSER_OUTPUT: 22:26:46 INFO - 2015-11-12 22:26:46,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47682/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:47 INFO - 2015-11-12 22:26:47,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 137560064 22:26:47 INFO - 2015-11-12 22:26:47,317 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-12 22:26:50,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47682/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:51 INFO - 2015-11-12 22:26:51,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 22:26:51 INFO - 2015-11-12 22:26:51,305 DEBUG : BROWSER_OUTPUT: 22:26:54 INFO - 2015-11-12 22:26:54,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47682/tests/kraken/driver.html?testName=json-parse-financial) 22:26:54 INFO - 2015-11-12 22:26:54,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 138944512 22:26:54 INFO - 2015-11-12 22:26:54,734 DEBUG : BROWSER_OUTPUT: 22:26:56 INFO - 2015-11-12 22:26:56,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:56 INFO - 2015-11-12 22:26:56,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 138280960 22:26:56 INFO - 2015-11-12 22:26:56,872 DEBUG : BROWSER_OUTPUT: 22:26:58 INFO - 2015-11-12 22:26:58,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:26:59 INFO - 2015-11-12 22:26:59,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 137973760 22:26:59 INFO - 2015-11-12 22:26:59,301 DEBUG : BROWSER_OUTPUT: 22:27:01 INFO - 2015-11-12 22:27:01,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:01 INFO - 2015-11-12 22:27:01,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 139177984 22:27:01 INFO - 2015-11-12 22:27:01,986 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-11-12 22:27:04,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:05 INFO - 2015-11-12 22:27:05,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 22:27:05 INFO - 2015-11-12 22:27:05,027 DEBUG : BROWSER_OUTPUT: 22:27:07 INFO - 2015-11-12 22:27:07,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:08 INFO - 2015-11-12 22:27:08,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 138829824 22:27:08 INFO - 2015-11-12 22:27:08,188 DEBUG : BROWSER_OUTPUT: 22:27:09 INFO - 2015-11-12 22:27:09,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47682/tests/kraken/driver.html?testName=ai-astar) 22:27:10 INFO - 2015-11-12 22:27:10,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 139304960 22:27:10 INFO - 2015-11-12 22:27:10,120 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,123 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:10 INFO - 2015-11-12 22:27:10,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:10 INFO - 2015-11-12 22:27:10,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:10 INFO - 2015-11-12 22:27:10,123 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;110;111;113;124;113;111;114;112 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;155;170;127;153;156;126;160;137 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;163;161;162;162;163;171;166;163 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;72;75;73;72;135;72;74;73 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;91;135;91;91;90;144;92;91;136 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;111;110;110;110;109;110;111;113;110 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;148;148;146;148;147;148;147;147 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;97;96;97;97;97 22:27:10 INFO - 2015-11-12 22:27:10,124 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;60;61;60;60;61;62;59;60 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;67;68;67;67;67;66;66;68 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;88;87;87;86;94;89;96;87 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;115;137;129;121;122;122;120;122;124 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;149;148;150;153;151;142;146;150;150 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;77;66;67;66;66;65;68;66;66 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:27:10 INFO - 2015-11-12 22:27:10,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,738 22:27:10 INFO - 2015-11-12 22:27:10,126 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:27:10 INFO - 2015-11-12 22:27:10,126 DEBUG : BROWSER_OUTPUT: __startTimestamp1447396030121__endTimestamp 22:27:10 INFO - 2015-11-12 22:27:10,126 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,129 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:10 INFO - 2015-11-12 22:27:10,129 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:27:10 INFO - 2015-11-12 22:27:10,130 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,130 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:4.45 (4.0%) stddev-sans-first:4.68 22:27:10 INFO - 2015-11-12 22:27:10,130 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 110.0 111.0 113.0 124.0 113.0 111.0 114.0 112.0 22:27:10 INFO - 2015-11-12 22:27:10,130 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,130 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.00 stddev:16.17 (10.5%) stddev-sans-first:17.04 22:27:10 INFO - 2015-11-12 22:27:10,130 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 155.0 170.0 127.0 153.0 156.0 126.0 160.0 137.0 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.91 (1.8%) stddev-sans-first:3.03 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 163.0 161.0 162.0 162.0 163.0 171.0 166.0 163.0 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:73.00 stddev:19.61 (26.9%) stddev-sans-first:20.62 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 72.0 75.0 73.0 72.0 135.0 72.0 74.0 73.0 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:91.00 stddev:23.13 (25.4%) stddev-sans-first:23.80 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 135.0 91.0 91.0 90.0 144.0 92.0 91.0 136.0 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,131 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:1.17 (1.1%) stddev-sans-first:1.13 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 110.0 110.0 110.0 109.0 110.0 111.0 113.0 110.0 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 148.0 148.0 146.0 148.0 147.0 148.0 147.0 147.0 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 97.0 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 60.0 61.0 60.0 60.0 61.0 62.0 59.0 60.0 22:27:10 INFO - 2015-11-12 22:27:10,132 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 68.0 67.0 67.0 67.0 66.0 66.0 68.0 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:87.50 stddev:3.47 (4.0%) stddev-sans-first:3.62 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 88.0 87.0 87.0 86.0 94.0 89.0 96.0 87.0 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:123.00 stddev:6.45 (5.2%) stddev-sans-first:6.23 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: Values: 132.0 115.0 137.0 129.0 121.0 122.0 122.0 120.0 122.0 124.0 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:150.00 stddev:4.32 (2.9%) stddev-sans-first:3.19 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: Values: 139.0 149.0 148.0 150.0 153.0 151.0 142.0 146.0 150.0 150.0 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:66.50 stddev:3.47 (5.2%) stddev-sans-first:3.68 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: Values: 67.0 77.0 66.0 67.0 66.0 66.0 65.0 68.0 66.0 66.0 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:10 INFO - 2015-11-12 22:27:10,133 DEBUG : BROWSER_OUTPUT: 22:27:11 INFO - 2015-11-12 22:27:11,179 INFO : Browser exited with error code: 0 22:27:11 INFO - 2015-11-12 22:27:11,233 INFO : Completed test kraken (00:01:00) 22:27:11 INFO - 2015-11-12 22:27:11,234 INFO : Starting test v8_7 22:27:11 INFO - 2015-11-12 22:27:11,234 DEBUG : operating with platform_type : linux_ 22:27:11 INFO - 2015-11-12 22:27:11,234 INFO : Initialising browser for v8_7 test... 22:27:11 INFO - 2015-11-12 22:27:11,240 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyWH6vF/profile http://localhost:47682/getInfo.html 22:27:15 INFO - 2015-11-12 22:27:15,996 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:27:15 INFO - 2015-11-12 22:27:15,996 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:27:15 INFO - 2015-11-12 22:27:15,996 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:27:15 INFO - 2015-11-12 22:27:15,996 DEBUG : BROWSER_OUTPUT: __metrics 22:27:17 INFO - 2015-11-12 22:27:17,091 INFO : Browser initialized. 22:27:17 INFO - 2015-11-12 22:27:17,091 INFO : Running cycle 1/1 for v8_7 test... 22:27:17 INFO - 2015-11-12 22:27:17,092 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyWH6vF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:27:28 INFO - 2015-11-12 22:27:28,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 140922880 22:27:28 INFO - 2015-11-12 22:27:28,887 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47682/tests/v8_7/run.html (next: http://localhost:47682/tests/v8_7/run.html) 22:27:50 INFO - 2015-11-12 22:27:50,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 138149888 22:27:50 INFO - 2015-11-12 22:27:50,579 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,579 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:50 INFO - 2015-11-12 22:27:50,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:50 INFO - 2015-11-12 22:27:50,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:50 INFO - 2015-11-12 22:27:50,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:50 INFO - 2015-11-12 22:27:50,581 DEBUG : BROWSER_OUTPUT: |0;Richards;162.49593760155997 22:27:50 INFO - 2015-11-12 22:27:50,581 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.19938176197837 22:27:50 INFO - 2015-11-12 22:27:50,581 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.46959748786753 22:27:50 INFO - 2015-11-12 22:27:50,581 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 22:27:50 INFO - 2015-11-12 22:27:50,582 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 22:27:50 INFO - 2015-11-12 22:27:50,582 DEBUG : BROWSER_OUTPUT: |5;Earley;722.543352601156 22:27:50 INFO - 2015-11-12 22:27:50,582 DEBUG : BROWSER_OUTPUT: |6;Boyer;11563.218390804597 22:27:50 INFO - 2015-11-12 22:27:50,582 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 22:27:50 INFO - 2015-11-12 22:27:50,583 DEBUG : BROWSER_OUTPUT: |8;Splay;623.2242124768376 22:27:50 INFO - 2015-11-12 22:27:50,583 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 22:27:50 INFO - 2015-11-12 22:27:50,583 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:50 INFO - 2015-11-12 22:27:50,583 DEBUG : BROWSER_OUTPUT: __startTimestamp1447396070578__endTimestamp 22:27:50 INFO - 2015-11-12 22:27:50,584 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,584 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:50 INFO - 2015-11-12 22:27:50,584 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:27:50 INFO - 2015-11-12 22:27:50,584 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,584 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.50 Median:162.50 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,585 DEBUG : BROWSER_OUTPUT: Values: 162.5 22:27:50 INFO - 2015-11-12 22:27:50,585 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,585 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.20 Median:193.20 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,585 DEBUG : BROWSER_OUTPUT: Values: 193.2 22:27:50 INFO - 2015-11-12 22:27:50,586 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,586 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.47 Median:285.47 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,586 DEBUG : BROWSER_OUTPUT: Values: 285.5 22:27:50 INFO - 2015-11-12 22:27:50,586 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,586 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,586 DEBUG : BROWSER_OUTPUT: Values: 5025.1 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: Values: 1058.2 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: Values: 722.5 22:27:50 INFO - 2015-11-12 22:27:50,587 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11563.22 Median:11563.22 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: Values: 11563.2 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: Values: 25250.0 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:623.22 Median:623.22 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,588 DEBUG : BROWSER_OUTPUT: Values: 623.2 22:27:50 INFO - 2015-11-12 22:27:50,589 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-12 22:27:50,589 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 22:27:50 INFO - 2015-11-12 22:27:50,589 DEBUG : BROWSER_OUTPUT: Values: 4822.1 22:27:50 INFO - 2015-11-12 22:27:50,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:50 INFO - 2015-11-12 22:27:50,589 DEBUG : BROWSER_OUTPUT: 22:27:51 INFO - 2015-11-12 22:27:51,471 INFO : Browser exited with error code: 0 22:27:51 INFO - 2015-11-12 22:27:51,488 INFO : Completed test v8_7 (00:00:40) 22:27:51 INFO - 2015-11-12 22:27:51,612 INFO : Completed test suite (00:20:10) 22:27:51 INFO - 2015-11-12 22:27:51,612 DEBUG : Working with test: dromaeo_css 22:27:51 INFO - 2015-11-12 22:27:51,612 DEBUG : Generating results file: dromaeo_css 22:27:51 INFO - 2015-11-12 22:27:51,613 DEBUG : Working with test: kraken 22:27:51 INFO - 2015-11-12 22:27:51,613 DEBUG : Generating results file: kraken 22:27:51 INFO - 2015-11-12 22:27:51,614 INFO : javascript benchmark 22:27:51 INFO - 2015-11-12 22:27:51,614 DEBUG : Working with test: v8_7 22:27:51 INFO - 2015-11-12 22:27:51,614 DEBUG : Generating results file: v8_7 22:27:51 INFO - 2015-11-12 22:27:51,615 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:51 INFO - 2015-11-12 22:27:51,665 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 22:27:51 INFO - 2015-11-12 22:27:51,665 DEBUG : process_Request line: dromaeo_css 6580.33 graph.html#tests=[[72,64,43]] 22:27:51 INFO - 2015-11-12 22:27:51,665 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:51 INFO - 2015-11-12 22:27:51,700 DEBUG : process_Request line: kraken 1516.50 graph.html#tests=[[232,64,43]] 22:27:51 INFO - 2015-11-12 22:27:51,700 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:51 INFO - 2015-11-12 22:27:51,802 DEBUG : process_Request line: v8_7 21448.14 graph.html#tests=[[230,64,43]] 22:27:51 INFO - 2015-11-12 22:27:51,804 INFO : javascript benchmark 22:27:51 INFO - 2015-11-12 22:27:51,807 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [334.8242172859249, 335.72638299785666, 336.17133765268613, 336.53558089836054, 336.99494507582375, 12454.190477618948, 12703.364831758421, 16277.104759238237, 16428.589285267873, 17440.47678569643, 11460.770784584303, 11484.425778711053, 11503.252288601236, 11572.479238434269, 11822.290662560252, 4447.666425018128, 4564.041551274237, 4570.268756998881, 4579.496255411918, 4585.72485650862, 4468.240399132155, 4607.216773148556, 4609.884752881171, 4614.238650622643, 4614.46933602635, 4554.954450455486, 4575.26795712686, 4631.235846085408, 4763.214069678499, 4768.308595253686, 4737.644676649265, 4739.383880095583, 4742.027884283748, 4742.075295317414, 4762.238041913294, 4052.6150015748754, 4160.771157586331, 4165.416841642173, 4169.97915010423, 4172.395002724588, 13342.865856402217, 13436.596902092855, 13511.459541618324, 13609.183448993092, 13734.793978090336, 1817.2458429751637, 1830.6979348407497, 1843.6497065557635, 1845.704687250047, 1995.1321175288651, 9395.906040939572, 9490.90509094907, 9543.856842147305, 9687.564059617334, 9754.512274386252, 1737.574294297905, 1739.5216315513208, 1761.9076172772834, 1783.0460703523552, 1817.572870375474, 57654.0, 59625.0, 60232.69883650597, 60464.0, 60506.69746651283, 6568.96715516429, 6638.966805165944, 6653.434458071021, 6690.765823196262, 6714.563553369016, 7755.3407960324, 7771.10632277284, 7792.454528182972, 7866.7639970800965, 7867.0, 4928.827491037797, 4957.206846904478, 4966.304717339575, 5102.4897510248675, 5159.432462429129, 4722.244440889442, 4781.2350023996, 4788.952110478851, 4910.680805747615, 4975.651704380731, 3082.2448500117166, 3110.1913502489515, 3113.719765221141, 3126.3903538809714, 3153.716165545112, 1111.766529028897, 1125.139268459629, 1127.2165844737992, 1133.812920868064, 1168.4741866160261, 339.61114523870526, 339.96940275375334, 341.54233327341484, 341.9743519236067, 370.13019404399444, 9596.0, 9970.152537034433, 10024.699259022242, 10093.747656308651, 10206.183505319557, 367.02554717225274, 370.3481871905466, 374.8275793135188, 377.8927741716796, 380.2679841305476, 5385.9730701347025, 5410.864728381822, 5439.5104440600535, 5523.116301391758, 5533.142362933751, 498488.0, 498821.0, 502020.87874726905, 512740.0, 517852.0, 76665.23334766581, 77722.6113869427, 77780.0, 77792.61103694445, 79199.0, 372.9347364211252, 377.1175449448304, 377.98488060477825, 378.7840930669492, 379.035355021471, 9014.28728541575, 9139.954300228455, 9167.404118732527, 9247.029061948668, 9334.25325973934, 33232.667673322954, 34673.13317167091, 34987.30025399529, 35310.823445882605, 35420.29159416746, 47285.2907206399, 47602.285965711235, 47845.0, 47859.521404785504, 48189.27716084332, 6309.936900631119, 6446.0, 6571.244306904576, 6572.112764776885, 6580.21037475506, 11990.0, 12144.696382590153, 12187.329696866758, 12281.93859030699, 12426.5650702225, 9448.669296574586, 10112.191024718151, 10545.841812372668, 10563.788724225318, 10604.310719803188, 10396.376217426978, 10404.531796069045, 10466.215033872642, 10512.106470950055, 11008.0, 10548.683539493828, 10570.154387649123, 10725.463726813472, 10998.670039898816, 11111.555537778722, 6598.637074960923, 6688.665566721742, 6694.129763130762, 6716.764913228014, 6717.361850624183, 10451.372917624967, 10491.475426228812, 10602.946985265333, 10763.085137763377, 11212.27120237182], "dojo.html": [3266.8366581670916, 3289.24347400098, 3294.6540613235625, 3320.5683261176046, 3341.983290083549, 5363.597730170233, 5458.9454105458935, 5562.86092847679, 5572.972135139324, 5580.330360356753, 5448.945510544893, 5474.0, 5515.917261241085, 5551.500364967153, 5566.0, 4919.040787046536, 5002.299678045077, 5056.747162641872, 5087.516685914832, 5095.643304968654, 5012.924806127911, 5084.110280700881, 5154.819581314636, 5181.611379146579, 5185.922211166836, 4860.173770458995, 4981.128302547076, 4985.501449855022, 5084.313617661605, 5113.105206588851, 4988.501149885019, 5042.243663450475, 5058.873528161788, 5063.063333283354, 5084.694918304914, 5111.335526381584, 5115.693058416507, 5126.974365128188, 5128.974355128238, 5163.845084647466, 5283.181106928432, 5288.735563221823, 5369.463053694639, 5434.130539113723, 5464.508194262496, 6025.3372129065765, 6037.547183961176, 6046.062860256668, 6054.697265136726, 6077.3314935357075, 6063.090536419529, 6063.787767428163, 6073.362296958844, 6099.939000609981, 6103.0, 5485.890282194374, 5534.114541673353, 5559.388467268597, 5624.100143976944, 5678.943210567924, 6049.3950604939155, 6074.817755467343, 6081.361457046946, 6086.330503644595, 6118.449339559461, 5648.548116150698, 5824.621399609012, 5827.650340979555, 5833.270841144857, 5864.296284445893, 5756.683382413924, 5926.822195334147, 5953.910691339634, 5955.67243801595, 5957.225560677084, 5935.614185077956, 6010.278766548042, 6041.214642096587, 6067.7269522871575, 6089.1779609753, 5762.366139724627, 5912.201852749909, 6025.216721826222, 6037.818865434044, 6090.056041313604, 4515.909681806345, 4522.615577675869, 4530.682852200381, 4598.747068911242, 4633.443986721615, 4082.652974497201, 4090.734102283342, 4096.73371230869, 4114.629683328515, 4126.958730412657, 5464.426235245322, 5618.775248989995, 5655.3779084300695, 5672.801451949162, 5691.146328050825, 5852.502537284378, 5925.525957923356, 5957.4042595740075, 5990.400959903975, 6006.579539432285, 5520.806771762969, 5618.101103823368, 5639.689817060101, 5668.518175955008, 5699.2590963174525, 5042.672226305279, 5140.485951404829, 5180.792768289226, 5182.97408512955, 5208.453112423217, 6103.155845961415, 6165.1985241919165, 6171.783987560414, 6183.81448556544, 6196.349383314777, 5957.970210148921, 5986.970065149646, 5987.13186587951, 6017.699115044143, 6023.30731965812, 6020.277566692025, 6130.908036379547, 6231.532635052298, 6271.843203919939, 6290.654014029089, 5827.3007239131575, 5829.7959571416495, 5844.6493210405815, 5894.351621321737, 5911.615744976562, 5970.044792833126, 5980.760769569169, 5989.221401217814, 5993.280806303272, 5993.490553303018, 5656.85857853557, 5757.0788673811985, 5814.098814683731, 5828.6502809831545, 5931.258592675916, 5822.621529600562, 5839.357670656309, 5847.210626565359, 5849.3858144894175, 5865.560082993878, 5705.0, 5741.712914354349, 5742.7702891883855, 5747.798827041033, 5754.971225143848, 5732.5413966881715, 5813.069908814569, 5837.0, 5923.200367950444, 5927.940720592911, 5791.739371728198, 5806.506446952057, 5821.476067153976, 5824.504917081926, 5827.854303642443], "mootools.html": [1505.7139143562729, 1715.0910017690624, 1764.5323989142871, 1775.201159478235, 1793.3006127610226, 5881.059030555112, 6026.276846778387, 6071.908921366177, 7272.418206543477, 7472.402207823375, 7354.521956072865, 7371.926280737204, 7379.446541509382, 7407.8888816667795, 7457.440691948112, 1981.4650044488017, 1999.9500012499732, 2015.3450128708155, 2016.7882372350912, 2019.061136571494, 2217.3126330837413, 2228.944276393095, 2247.820174386045, 2267.965980510294, 2268.9773102269014, 2070.213318938801, 2071.730675012246, 2116.153538584563, 2135.6155891939443, 2147.0338347743577, 2153.267888917768, 2156.644153714635, 2169.826413886893, 2175.369142948551, 2199.8350123740784, 2217.2904670505445, 2234.218023691711, 2242.551489702066, 2246.7977881990537, 2255.436140964759, 7124.536905101152, 7224.1692205396, 7231.602261875595, 7243.384312333458, 7255.854882902365, 4402.801873915681, 4481.7983190756495, 4485.013297074638, 4485.708428952108, 4489.7979590918485, 2752.5320695481814, 2890.132960111979, 2905.941881162365, 2916.5916771651987, 2935.530315149566, 876.071364353787, 899.8920129584426, 910.2035718746097, 946.5125460387906, 948.672707915768, 9542.570584323723, 9687.51562421876, 9718.222542196678, 9721.31950763447, 9746.805063898753, 3733.309337772521, 3853.614638536124, 3898.3372826618975, 3904.1801221743754, 3920.4707364506, 7913.723019694283, 7969.565478213977, 7999.480033797785, 8008.719694810654, 8010.158933312035, 4342.5657434256955, 4348.652107831366, 4352.151330490524, 4371.737695738266, 4383.3863259143745, 3963.801809909493, 3972.682185425159, 3972.880813575597, 3975.4633124528395, 4002.1195337025806, 3216.5979252593424, 3224.081136875979, 3245.951310730341, 3246.935061298761, 3252.9674703253136, 996.6212839121088, 997.0229175408141, 997.6109317366088, 998.4758002048983, 1007.1087087927237, 975.9560819762986, 980.0395612299986, 1065.9573617055387, 1092.6776600902595, 1281.7564662714242, 6112.7554897804475, 6128.264608247039, 6134.693265336716, 6150.015997440388, 6186.412290832363, 1112.1380929779325, 1113.582406597526, 1123.4607388453426, 1127.2898074213192, 1171.1392126786805, 5139.254808052811, 5143.691378517301, 5184.818531351385, 5185.792568297225, 5189.792408303626, 8448.704295349757, 8492.193241642035, 8640.654373824977, 8689.391742578086, 8721.0, 8428.704995325133, 8504.489730616182, 8539.658413663385, 8551.700690475927, 8569.885914831157, 6751.054852320679, 6806.285340039323, 6810.774060669127, 6837.555558888656, 6847.452203823682, 6238.906416403667, 6242.687865606792, 6266.905996409966, 6289.874202515833, 6308.653024083719, 7520.511166774142, 7524.322810946822, 7634.50375725576, 7672.810714339286, 7798.883016754639, 7725.845483090419, 7787.649555769891, 7862.646180921986, 7865.921340786519, 7926.445148839526, 6244.906326405016, 6261.530385221217, 6332.873342533031, 6341.55609107358, 6350.047492876106, 6992.61540615271, 7020.0, 7039.788806335818, 7042.471814614027, 7088.2202957675645, 6267.310595834363, 6483.351664833479, 6489.545731798728, 6557.868842623217, 6646.8005959821285, 6263.874722505433, 6354.555181137276, 6374.521910856612, 6451.516136289703, 6475.708593113415, 5977.22296101504, 6010.639361638316, 6044.304904935989, 6072.514198864169, 6115.266168059861, 5541.944580554143, 5547.41752116022, 5558.72206389687, 5567.944320556905, 5575.135853942646, 5610.887782244414, 5629.662220266797, 5657.094864821609, 5665.5750818689585, 5666.801661941812], "ext.html": [559.1919676068084, 593.8990371636821, 600.8377738010737, 601.5849064145742, 602.7287720525763, 39784.20431591367, 40371.79814100929, 40436.0, 40476.79761601195, 40662.0, 41580.37629435561, 42349.0, 42394.0, 42397.36403953935, 42437.151256974845, 8677.783055423602, 8806.86789698155, 8876.378653494257, 8912.331575131859, 8917.152870477294, 8625.870611940825, 8651.221390074892, 8702.521361325125, 8730.257928076122, 8740.0, 8561.272291855199, 8690.304775617935, 8721.60752766124, 8743.95628021859, 8745.169208925174, 8660.220580147818, 8666.826663466727, 8751.256143227833, 8755.299576033934, 8783.47299162046, 8543.95728021362, 8668.566571671392, 8692.695755648585, 8700.042995270514, 8709.25971292441, 38969.80515097406, 39478.60521394778, 39573.60426395757, 39592.0, 40025.59974400277, 3066.31008023193, 3465.6707612776745, 3997.920041599181, 4001.279769641463, 4109.116539943897, 29205.123846284645, 29623.851880740673, 29775.404491910256, 30419.69580304191, 30478.84760576205, 3301.4552598821165, 3397.8640854365794, 3415.0949998250485, 3417.624061353249, 3420.110771199506, 270086.0, 270791.0, 270844.0, 271222.0, 271663.0, 55733.0, 57264.0, 57442.13836792451, 57842.4215757837, 58871.70564147152, 53655.0, 53804.730976344865, 53916.0, 54014.18978715244, 54307.0, 13857.792133118011, 13889.097208681404, 13899.930500347433, 13950.720985580232, 14009.43962241499, 10686.038256556947, 10764.569417223223, 10781.299215550964, 10845.295055821347, 10864.130869530418, 19227.22862189939, 19669.21323147058, 19764.901175494317, 19809.20763169486, 19822.70265946012, 7571.3564347030015, 7698.538087714643, 7798.961005194938, 7802.726904558313, 7808.180141085218, 859.1623167411724, 868.8827008353792, 957.2533423929207, 960.577345967786, 1107.855978722761, 28793.28016799555, 28793.712062879524, 28866.71133288682, 29009.12972610825, 29132.563011554845, 1014.4978235773192, 1022.5551884930079, 1034.5603118674533, 1111.2665640677114, 1133.6485689436136, 14882.479113230986, 14948.252587370587, 14977.326020329112, 15157.166355850533, 15210.847891521165, 323279.0, 325600.0, 325614.0, 326030.0, 328289.0, 52373.214401784004, 52533.47466525362, 52735.20897186545, 53089.46910530845, 53201.2019819703, 1318.1168617026424, 1354.5462270139615, 1369.7945308203848, 1379.6206043338161, 1380.9930950345183, 27749.167524974284, 28465.0, 28648.14055578336, 28737.0, 28851.7114828849, 46782.76608616935, 47111.528884710715, 47326.29010564776, 47346.28980565363, 47364.2895356563, 294601.0, 295915.0, 296250.0, 296661.0, 296905.0, 28103.57844632373, 28539.714602853706, 31650.208744781565, 32460.738211479027, 34619.13452163615, 41625.1674966505, 41764.0, 42087.789561052, 42711.7864410676, 42717.0, 34881.30237395187, 35462.0, 36006.63993360033, 36614.0, 36849.26301474009, 33764.0, 35360.29279414449, 35575.46636800502, 36222.8188859054, 36967.630323696416, 33940.83029584836, 34051.14872128217, 36316.81841590775, 36619.0, 36862.262754745294, 28588.42823143484, 30145.0, 31026.534601980537, 31132.22169445782, 32142.0, 24918.50162996766, 25197.0, 25249.74750252474, 25335.0, 25437.745622544277], "prototype.html": [281.25748025213426, 293.4629627781162, 294.1645726137769, 300.44567772459806, 300.50716824407976, 6167.845803854901, 6289.710609325089, 6295.842603934898, 6309.179806625144, 6423.389777971085, 6291.402316779899, 6307.3692630736905, 6307.810765677025, 6333.145025421567, 6346.301906790261, 4707.270373092176, 4712.316714076457, 4713.057388522292, 4717.858464246061, 4735.218688916325, 4712.034033023239, 4716.245400735883, 4716.669833111683, 4716.9292460613115, 4723.5512626300615, 4583.175028494869, 4671.439427268732, 4693.859184224479, 4695.131400690883, 4698.436187657486, 4661.463931647853, 4688.179568575486, 4688.249880019198, 4690.976545117287, 4702.576768090888, 4004.439378487014, 4007.1184339445276, 4007.7595344279434, 4013.2776100301935, 4014.7992600369867, 5929.080992446177, 5951.613145145551, 5954.761809527614, 5983.222181116471, 6001.06983417571, 5311.517051825257, 5374.220737993008, 5445.264889239941, 5448.782048718046, 5450.427705090948, 6673.432758215557, 6685.732570697215, 6686.297938716462, 6690.063391125246, 6691.464682825363, 4400.44994375703, 4437.0682156747125, 4440.733555986619, 4443.466783985942, 4446.799894004777, 6626.668666566652, 6786.966065169692, 6874.0, 6951.339622735832, 6969.965150174267, 4371.278739008092, 4383.452068491439, 4387.912241755211, 4389.385486031958, 4395.077033822933, 4438.578335058164, 4439.067795762861, 4440.955590444119, 4446.355278484666, 4446.9555304447185, 5241.659292145999, 5286.444923283, 5286.550643195372, 5289.550388216968, 5297.073012222922, 6538.280789113289, 6669.699863506154, 6709.563878347989, 6736.46108311334, 6743.2919543448215, 1584.8335924727737, 1588.8172860121003, 1591.3952697974696, 1592.3471376735483, 1600.1119378744909, 1067.412922892406, 1070.2936062199067, 1076.424113099488, 1081.6052140968648, 1087.9401632910267, 6346.8413289667205, 6354.3963323484195, 6360.872782544323, 6370.267419246753, 6384.7126879290545, 6772.255051944282, 6794.422474089758, 6802.217744959393, 6829.965850170717, 6843.8973415398805, 6210.254769427607, 6312.8421789454715, 6346.0, 6361.109444677749, 6377.904331435032, 3715.238376132886, 3723.8138093095235, 3731.048582611417, 3739.3456145174487, 3745.194783121642, 7063.611501367372, 7127.786166415016, 7128.932609543278, 7136.215016348197, 7173.282671732889, 6978.476614253951, 6995.475339349569, 7009.2990700929495, 7014.964925175444, 7020.403265722369, 7307.0, 7348.485606007635, 7360.0431943848025, 7369.520981136209, 7377.704891804375, 6994.650267486707, 7006.719731210898, 7012.544184627983, 7019.5788252705, 7020.22777494465, 6821.249662537216, 6915.377616014583, 6929.064576282339, 6934.375906168469, 6944.826379340557, 7286.234945330876, 7328.890066649111, 7337.633118344168, 7338.633068346669, 7350.70597176107, 4488.573585509372, 4532.70537415067, 4535.7958891849285, 4537.8184872604725, 4540.409746732904, 6861.382475577222, 6921.307869213038, 6945.166580010431, 6963.0, 6979.092717946837, 6758.831029224309, 6765.391114799691, 6771.39057484809, 6775.457963363017, 6776.525643205126, 6688.264290927897, 6757.020232066225, 6761.695723692347, 6764.695588698422, 6767.424768894699, 6431.742730290923, 6590.670466476753, 6596.109525214035, 6597.0764093026055, 6612.537122401386, 6760.661966901734, 6767.661616919036, 6785.9660701696175, 6789.321067893368, 6801.18385793708, 6615.305392933673, 6633.1045308882685, 6640.734370625121, 6642.83392915181, 6643.169603799525], "yui.html": [660.3000819131721, 759.161126954715, 760.2853317881192, 762.5462849604484, 778.6729573579096, 14091.929540352297, 14551.708965820677, 14561.0, 14626.634334141638, 14652.560423187308, 12233.877661223385, 12830.486780528767, 12848.74302513949, 12895.742085158292, 12923.966082713383, 817.5217497763815, 829.3531045784267, 830.9252167304942, 832.3840358134997, 833.5665453963935, 828.2297463359074, 836.0510820219065, 836.636063312458, 837.0123254559617, 839.2740279658112, 875.3259989807876, 875.6366108065146, 885.8272636835819, 889.9911000890005, 890.568074483878, 874.0909454167657, 877.7981064355203, 882.4881568690176, 883.4037025008093, 887.5029983209423, 646.4860435953382, 653.3694984340135, 653.9084528166061, 655.1352215076101, 656.3338211715113, 12879.905208057233, 12971.935140324238, 12993.545225917142, 13037.15258508194, 13115.606531804062, 11872.465739041763, 11920.0, 12082.33547154906, 12364.319962402064, 12366.072544559103, 9745.220382369464, 9791.216702663769, 9886.653967111117, 9958.452285124315, 10091.2431567632, 3583.4266517357096, 3622.1669016126175, 3654.086478380405, 3661.1030297577, 3740.1397678533817, 47883.76058119687, 48480.27279590809, 48597.0, 48696.269555956686, 49068.99999999964, 8887.111288871061, 9126.498042607587, 9146.359754817233, 9210.401323914059, 9515.666951656658, 18620.16209270586, 18776.155073021746, 18809.43571692824, 18819.059047047595, 18894.149763260688, 7447.478676492594, 7499.812504687427, 7596.544207347577, 7618.771436856903, 7707.0, 4117.794110294473, 4191.036061705825, 4192.664586833046, 4198.8110535026, 4221.704480686384, 3000.6099207103375, 3014.8794048237824, 3026.757859371245, 3028.4851575231824, 3031.3028003559307, 436.5765207748479, 438.07566035664723, 443.72489056785, 451.41316288824396, 452.93206019097397, 505.92664063711294, 561.2675458526662, 632.2634131237149, 673.4545018535002, 680.1939701453794, 8361.916380836235, 8370.414071014971, 8646.394752367274, 8723.956380218058, 8818.470891746516, 582.8805094955524, 609.9512039036866, 614.8616561273767, 677.3091446724313, 708.3200127877193, 4079.592040795956, 4150.252954468225, 4196.622303992655, 4223.852165174204, 4251.213525497793, 52762.47237527652, 58503.0, 58649.0, 59367.703161483914, 60542.697286513285, 43320.13359732851, 44222.33666495005, 45001.324980125326, 47694.28458573124, 47799.283010754865, 44828.3275750864, 45995.0, 46300.0, 46781.0, 47351.05297894023, 8217.54803485814, 8449.45078569891, 8757.124287571192, 8776.297896168164, 8831.072737362485, 35264.47103293504, 35424.0, 35472.113197169245, 35939.46090808588, 36053.45919811152, 39979.0, 40570.94290570919, 43585.346219806095, 44038.55961440344, 44446.555534445535, 7287.0, 7301.269873012656, 7314.0, 7333.552900785444, 7387.0, 11601.446827116124, 11612.303261804318, 11665.59170429031, 11888.940555297168, 12111.878881211074, 11240.325580465198, 11282.717932051764, 11629.709257268636, 11728.882711172779, 12109.636710898687, 11351.602693905674, 11527.538898444303, 11574.594889178838, 11784.351860647746, 11921.642350729491, 10966.616168434066, 11199.272047316897, 11277.379744114152, 11311.547538098384, 11651.47568359409, 9155.496447695441, 9256.25949924018, 9258.53707314645, 9298.302627302844, 9788.559514821993, 8406.915930840858, 8615.6984505542, 9010.189082982562, 9200.26397888154, 9320.254379649747]}, "summary": {"lowerIsBetter": false, "suite": 6580.327402855893, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6445.837545481678, "unit": "ms", "value": 6445.837545481678}, "dojo.html": {"lowerIsBetter": false, "filtered": 5497.201800547602, "unit": "ms", "value": 5497.201800547602}, "mootools.html": {"lowerIsBetter": false, "filtered": 4120.7936332024, "unit": "ms", "value": 4120.7936332024}, "ext.html": {"lowerIsBetter": false, "filtered": 18290.940117240556, "unit": "ms", "value": 18290.940117240556}, "prototype.html": {"lowerIsBetter": false, "filtered": 4947.359066418993, "unit": "ms", "value": 4947.359066418993}, "yui.html": {"lowerIsBetter": false, "filtered": 6143.780229540887, "unit": "ms", "value": 6143.780229540887}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-067.e"}, "testrun": {"date": 1447394861, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112203045", "branch": "Fx-Team", "revision": "4b2ec935bc99bc505776190210b11dfe552bd041"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 163.0, 161.0, 162.0, 162.0, 163.0, 171.0, 166.0, 163.0], "ai-astar": [111.0, 107.0, 110.0, 111.0, 113.0, 124.0, 113.0, 111.0, 114.0, 112.0], "imaging-gaussian-blur": [112.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 113.0, 110.0], "audio-beat-detection": [151.0, 124.0, 155.0, 170.0, 127.0, 153.0, 156.0, 126.0, 160.0, 137.0], "json-stringify-tinderbox": [68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0], "stanford-crypto-pbkdf2": [139.0, 149.0, 148.0, 150.0, 153.0, 151.0, 142.0, 146.0, 150.0, 150.0], "json-parse-financial": [61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 62.0, 59.0, 60.0], "stanford-crypto-sha256-iterative": [67.0, 77.0, 66.0, 67.0, 66.0, 66.0, 65.0, 68.0, 66.0, 66.0], "audio-fft": [72.0, 75.0, 72.0, 75.0, 73.0, 72.0, 135.0, 72.0, 74.0, 73.0], "imaging-darkroom": [146.0, 146.0, 148.0, 148.0, 146.0, 148.0, 147.0, 148.0, 147.0, 147.0], "stanford-crypto-ccm": [132.0, 115.0, 137.0, 129.0, 121.0, 122.0, 122.0, 120.0, 122.0, 124.0], "audio-oscillator": [89.0, 91.0, 135.0, 91.0, 91.0, 90.0, 144.0, 92.0, 91.0, 136.0], "stanford-crypto-aes": [87.0, 86.0, 88.0, 87.0, 87.0, 86.0, 94.0, 89.0, 96.0, 87.0], "imaging-desaturate": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1516.5000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.3, "unit": "ms", "value": 79.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.8, "unit": "ms", "value": 147.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.9, "unit": "ms", "value": 145.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.4, "unit": "ms", "value": 124.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.5, "unit": "ms", "value": 60.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.0, "unit": "ms", "value": 105.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.6, "unit": "ms", "value": 112.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.6, "unit": "ms", "value": 163.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.6, "unit": "ms", "value": 110.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.7, "unit": "ms", "value": 88.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.5, "unit": "ms", "value": 96.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-067.e"}, "testrun": {"date": 1447394861, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112203045", "branch": "Fx-Team", "revision": "4b2ec935bc99bc505776190210b11dfe552bd041"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.19938176197837], "Encrypt": [285.46959748786753], "NavierStokes": [4822.115384615385], "Decrypt": [5025.125628140703], "Splay": [623.2242124768376], "Richards": [162.49593760155997], "RegExp": [25250.0], "Earley": [722.543352601156], "Boyer": [11563.218390804597], "RayTrace": [1058.2010582010582]}, "summary": {"lowerIsBetter": false, "suite": 21448.143782658968, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 342.226768, "unit": "score", "value": 342.226768}, "Encrypt": {"lowerIsBetter": false, "filtered": 932.4320429999997, "unit": "score", "value": 932.4320429999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.970019, "unit": "score", "value": 52.970019}, "Splay": {"lowerIsBetter": false, "filtered": 130.75711496531218, "unit": "score", "value": 130.75711496531218}, "RegExp": {"lowerIsBetter": false, "filtered": 36.07861386138617, "unit": "score", "value": 36.07861386138617}, "Richards": {"lowerIsBetter": false, "filtered": 217.24850799999996, "unit": "score", "value": 217.24850799999996}, "Earley": {"lowerIsBetter": false, "filtered": 922.3847919999998, "unit": "score", "value": 922.3847919999998}, "Boyer": {"lowerIsBetter": false, "filtered": 57.636462226640134, "unit": "score", "value": 57.636462226640134}, "RayTrace": {"lowerIsBetter": false, "filtered": 699.2896049999997, "unit": "score", "value": 699.2896049999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-067.e"}, "testrun": {"date": 1447394861, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112203045", "branch": "Fx-Team", "revision": "4b2ec935bc99bc505776190210b11dfe552bd041"}}] 22:27:51 INFO - RETURN: dromaeo_css: 6580.33 22:27:51 INFO - RETURN: kraken: 1516.50 22:27:51 INFO - RETURN: v8_7: 21448.14 22:27:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21448.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6580.33"}}} 22:27:51 INFO - Return code: 0 22:27:51 INFO - # TBPL SUCCESS # 22:27:51 INFO - Running post-action listener: _resource_record_post_action 22:27:51 INFO - Running post-run listener: _resource_record_post_run 22:27:52 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508841984; Read time: 28; Write time: 383960 22:27:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 221319168; Read time: 0; Write time: 238680 22:27:53 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287522816; Read time: 28; Write time: 145280 22:27:53 INFO - Running post-run listener: _upload_blobber_files 22:27:53 INFO - Blob upload gear active. 22:27:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:27:53 INFO - Copying logs to upload dir... 22:27:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.924485 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-12 22:27:52.497588) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:52.501442) ========= 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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010100 build_url: 'https://queue.taskcluster.net/v1/task/XLX7xeh9R0apRFIrVn9L9g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:52.554109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:52.554493) ========= 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=3e14eba40af1795cf0357910000001c3-1447394075.54461-1419450259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 22:27:52.605112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 22:27:52.605475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 22:27:52.605802) ========= ========= Total master_lag: 0.23 =========