builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1448363913.27 results: success (0) buildid: 20151124023016 builduid: 934c9b56ca1f4766b7f03db7cab566b6 revision: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.274164) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.274699) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.275000) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.301534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.301843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.327330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.327712) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025773 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.380152) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.380748) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.381366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.381841) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 03:18:33-- 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% 216M=0s 2015-11-24 03:18:33 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.547664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.547992) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.133910 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:33.697943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 03:18:33.698296) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --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 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 03:18:33,946 truncating revision to first 12 chars 2015-11-24 03:18:33,946 Setting DEBUG logging. 2015-11-24 03:18:33,946 attempt 1/10 2015-11-24 03:18:33,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d1be94ff95a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 03:18:34,818 unpacking tar archive at: fx-team-9d1be94ff95a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.143249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 03:18:34.854343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:34.854662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:34.861899) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:34.862392) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:34.862855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2015-11-24 03:18:34.863143) ========= /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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:35 INFO - MultiFileLogger online at 20151124 03:18:35 in /builds/slave/test-pgo 03:18:35 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 03:18:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:18:35 INFO - {'append_to_log': False, 03:18:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:18:35 INFO - 'blob_upload_branch': 'Fx-Team', 03:18:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:18:35 INFO - 'branch': 'Fx-Team', 03:18:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:35 INFO - 'config_files': ('talos/linux_config.py',), 03:18:35 INFO - 'default_actions': ('clobber', 03:18:35 INFO - 'read-buildbot-config', 03:18:35 INFO - 'download-and-extract', 03:18:35 INFO - 'populate-webroot', 03:18:35 INFO - 'create-virtualenv', 03:18:35 INFO - 'install', 03:18:35 INFO - 'run-tests'), 03:18:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:35 INFO - 'download_minidump_stackwalk': True, 03:18:35 INFO - 'download_symbols': 'ondemand', 03:18:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:35 INFO - 'installer_path': 'installer.exe', 03:18:35 INFO - 'log_level': 'info', 03:18:35 INFO - 'log_name': 'talos', 03:18:35 INFO - 'log_to_console': True, 03:18:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:35 INFO - 'opt_config_files': (), 03:18:35 INFO - 'pip_index': False, 03:18:35 INFO - 'sps_profile': False, 03:18:35 INFO - 'sps_profile_interval': 0, 03:18:35 INFO - 'suite': 'dromaeojs-e10s', 03:18:35 INFO - 'system_bits': '64', 03:18:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:35 INFO - 'title': 'talos-linux64-ix-060', 03:18:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:35 INFO - 'use_talos_json': True, 03:18:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:18:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:35 INFO - 'work_dir': 'build'} 03:18:35 INFO - ##### 03:18:35 INFO - ##### Running clobber step. 03:18:35 INFO - ##### 03:18:35 INFO - Running pre-action listener: _resource_record_pre_action 03:18:35 INFO - Running main action method: clobber 03:18:35 INFO - rmtree: /builds/slave/test-pgo/build 03:18:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:18:39 INFO - Running post-action listener: _resource_record_post_action 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running read-buildbot-config step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: read_buildbot_config 03:18:39 INFO - Using buildbot properties: 03:18:39 INFO - { 03:18:39 INFO - "properties": { 03:18:39 INFO - "buildnumber": 104, 03:18:39 INFO - "product": "firefox", 03:18:39 INFO - "script_repo_revision": "production", 03:18:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:18:39 INFO - "repository": "", 03:18:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 03:18:39 INFO - "buildid": "20151124023016", 03:18:39 INFO - "slavename": "talos-linux64-ix-060", 03:18:39 INFO - "pgo_build": "True", 03:18:39 INFO - "basedir": "/builds/slave/test-pgo", 03:18:39 INFO - "project": "", 03:18:39 INFO - "platform": "ubuntu64_hw", 03:18:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:39 INFO - "slavebuilddir": "test", 03:18:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:18:39 INFO - "branch": "fx-team", 03:18:39 INFO - "repo_path": "integration/fx-team", 03:18:39 INFO - "stage_platform": "linux64-pgo", 03:18:39 INFO - "builduid": "934c9b56ca1f4766b7f03db7cab566b6", 03:18:39 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:18:39 INFO - }, 03:18:39 INFO - "sourcestamp": { 03:18:39 INFO - "repository": "", 03:18:39 INFO - "hasPatch": false, 03:18:39 INFO - "project": "", 03:18:39 INFO - "branch": "fx-team-linux64-pgo-talos", 03:18:39 INFO - "changes": [ 03:18:39 INFO - { 03:18:39 INFO - "category": null, 03:18:39 INFO - "files": [ 03:18:39 INFO - { 03:18:39 INFO - "url": null, 03:18:39 INFO - "name": "https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:18:39 INFO - } 03:18:39 INFO - ], 03:18:39 INFO - "repository": "", 03:18:39 INFO - "rev": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe", 03:18:39 INFO - "who": "sendchange", 03:18:39 INFO - "when": 1448363872, 03:18:39 INFO - "number": 6699696, 03:18:39 INFO - "comments": "", 03:18:39 INFO - "project": "", 03:18:39 INFO - "at": "Tue 24 Nov 2015 03:17:52", 03:18:39 INFO - "branch": "fx-team-linux64-pgo-talos", 03:18:39 INFO - "revlink": "", 03:18:39 INFO - "properties": [ 03:18:39 INFO - [ 03:18:39 INFO - "buildid", 03:18:39 INFO - "20151124023016", 03:18:39 INFO - "Change" 03:18:39 INFO - ], 03:18:39 INFO - [ 03:18:39 INFO - "builduid", 03:18:39 INFO - "934c9b56ca1f4766b7f03db7cab566b6", 03:18:39 INFO - "Change" 03:18:39 INFO - ], 03:18:39 INFO - [ 03:18:39 INFO - "pgo_build", 03:18:39 INFO - "True", 03:18:39 INFO - "Change" 03:18:39 INFO - ] 03:18:39 INFO - ], 03:18:39 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:18:39 INFO - } 03:18:39 INFO - ], 03:18:39 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:18:39 INFO - } 03:18:39 INFO - } 03:18:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:18:39 INFO - Running post-action listener: _resource_record_post_action 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running download-and-extract step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: download_and_extract 03:18:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:18:39 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')]} 03:18:39 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json 03:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json 03:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:18:43 INFO - Downloaded 1302 bytes. 03:18:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:18:43 INFO - Using the following test package requirements: 03:18:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'jsshell-linux-x86_64.zip'], 03:18:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:18:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:18:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:43 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')]} 03:18:43 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:46 INFO - Downloaded 22525996 bytes. 03:18:46 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 03:18:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:46 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 03:18:47 INFO - Return code: 0 03:18:47 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 03:18:47 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')]} 03:18:47 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:49 INFO - Downloaded 22525996 bytes. 03:18: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 03:18:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18: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 03:18:50 INFO - Return code: 0 03:18: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')]} 03:18:50 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:51 INFO - Downloaded 11130997 bytes. 03:18:51 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 03:18:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:51 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 03:18:51 INFO - Return code: 0 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:51 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:54 INFO - Downloaded 57577387 bytes. 03:18:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:54 INFO - mkdir: /builds/slave/test-pgo/properties 03:18:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:18:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:18:54 INFO - Contents: 03:18:54 INFO - build_url:https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:54 INFO - Running post-action listener: _resource_record_post_action 03:18:54 INFO - Running post-action listener: set_extra_try_arguments 03:18:54 INFO - ##### 03:18:54 INFO - ##### Running populate-webroot step. 03:18:54 INFO - ##### 03:18:54 INFO - Running pre-action listener: _resource_record_pre_action 03:18:54 INFO - Running main action method: populate_webroot 03:18:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:18:54 INFO - '../fennec_ids.txt'], 03:18:54 INFO - 'tests': ['tcheck2']}, 03:18:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:54 INFO - '--tppagecycles', 03:18:54 INFO - '7'], 03:18:54 INFO - 'tests': ['tsvgm']}}, 03:18:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:18:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:18:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:18:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'tests': ['damp', 'tps']}, 03:18:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['damp', 'tps']}, 03:18:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:18:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:54 INFO - 'other': {'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_no_auto_restore']}, 03:18:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_no_auto_restore']}, 03:18:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_no_auto_restore']}, 03:18:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_no_auto_restore']}, 03:18:54 INFO - 'other_l64': {'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_no_auto_restore']}, 03:18:54 INFO - 'other_nol64': {'tests': ['a11yr', 03:18:54 INFO - 'ts_paint', 03:18:54 INFO - 'tpaint', 03:18:54 INFO - 'sessionrestore', 03:18:54 INFO - 'sessionrestore_no_auto_restore']}, 03:18:54 INFO - 'svgr': {'tests': ['tsvgx', 03:18:54 INFO - 'tsvgr_opacity', 03:18:54 INFO - 'tart', 03:18:54 INFO - 'tscrollx', 03:18:54 INFO - 'cart']}, 03:18:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['tsvgx', 03:18:54 INFO - 'tsvgr_opacity', 03:18:54 INFO - 'tart', 03:18:54 INFO - 'tscrollx', 03:18:54 INFO - 'cart']}, 03:18:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'tests': ['tp5o']}, 03:18:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'talos_options': ['--e10s'], 03:18:54 INFO - 'tests': ['tp5o']}, 03:18:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'talos_options': ['--xperf_path', 03:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:54 INFO - 'tests': ['tp5n']}, 03:18:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:54 INFO - 'talos_options': ['--e10s', 03:18:54 INFO - '--xperf_path', 03:18:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:54 INFO - 'tests': ['tp5n']}}, 03:18:54 INFO - 'talos.zip': {'path': '', 03:18:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:54 INFO - Running post-action listener: _resource_record_post_action 03:18:54 INFO - ##### 03:18:54 INFO - ##### Running create-virtualenv step. 03:18:54 INFO - ##### 03:18:54 INFO - Running pre-action listener: _resource_record_pre_action 03:18:54 INFO - Running main action method: create_virtualenv 03:18:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:18:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:18:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:18:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:54 INFO - Using real prefix '/usr' 03:18:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:18:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:56 INFO - Installing pip.................done. 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 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 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:18:56 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 03:18:56 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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 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 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 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 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:18:56 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 03:18:56 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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:57 INFO - Downloading/unpacking psutil>=0.7.1 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:18:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:58 INFO - Installing collected packages: psutil 03:18:58 INFO - Running setup.py install for psutil 03:18:59 INFO - building 'psutil._psutil_linux' extension 03:18:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:18:59 INFO - building 'psutil._psutil_posix' extension 03:18:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:18:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:59 INFO - Successfully installed psutil 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:18:59 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')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:59 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')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:59 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 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:18:59 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 03:18:59 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 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:18:59 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 03:18:59 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 03:18:59 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 03:18:59 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 03:18:59 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 03:18:59 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 03:19:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:19:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:19:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:19:01 INFO - Installing collected packages: mozsystemmonitor 03:19:01 INFO - Running setup.py install for mozsystemmonitor 03:19:01 INFO - Successfully installed mozsystemmonitor 03:19:01 INFO - Cleaning up... 03:19:01 INFO - Return code: 0 03:19:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:19:01 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 03:19:01 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 03:19:01 INFO - Using env: {'DISPLAY': ':0', 03:19:01 INFO - 'HOME': '/home/cltbld', 03:19:01 INFO - 'LANG': 'en_US.UTF-8', 03:19:01 INFO - 'LANGUAGE': 'en_US:en', 03:19:01 INFO - 'LOGNAME': 'cltbld', 03:19:01 INFO - 'MAIL': '/var/mail/cltbld', 03:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:01 INFO - 'MOZ_NO_REMOTE': '1', 03:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:01 INFO - 'NO_EM_RESTART': '1', 03:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:01 INFO - 'SHELL': '/bin/bash', 03:19:01 INFO - 'SHLVL': '1', 03:19:01 INFO - 'TERM': 'linux', 03:19:01 INFO - 'TMOUT': '86400', 03:19:01 INFO - 'USER': 'cltbld', 03:19:01 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:01 INFO - '_': '/tools/buildbot/bin/python'} 03:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:01 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 03:19:01 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 03:19:01 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 03:19:01 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 03:19:01 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 03:19:01 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 03:19:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:19:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:19:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:19:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:04 INFO - Downloading docopt-0.6.1.tar.gz 03:19:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:19:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:04 INFO - Running setup.py install for blobuploader 03:19:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:19:04 INFO - Running setup.py install for requests 03:19:04 INFO - Running setup.py install for docopt 03:19:04 INFO - Successfully installed blobuploader requests docopt 03:19:04 INFO - Cleaning up... 03:19:04 INFO - Return code: 0 03:19:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19: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')]} 03:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:04 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 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:19:04 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 03:19:04 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 03:19:04 INFO - Using env: {'DISPLAY': ':0', 03:19:04 INFO - 'HOME': '/home/cltbld', 03:19:04 INFO - 'LANG': 'en_US.UTF-8', 03:19:04 INFO - 'LANGUAGE': 'en_US:en', 03:19:04 INFO - 'LOGNAME': 'cltbld', 03:19:04 INFO - 'MAIL': '/var/mail/cltbld', 03:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:04 INFO - 'MOZ_NO_REMOTE': '1', 03:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:04 INFO - 'NO_EM_RESTART': '1', 03:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:04 INFO - 'SHELL': '/bin/bash', 03:19:04 INFO - 'SHLVL': '1', 03:19:04 INFO - 'TERM': 'linux', 03:19:04 INFO - 'TMOUT': '86400', 03:19:04 INFO - 'USER': 'cltbld', 03:19:04 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:04 INFO - '_': '/tools/buildbot/bin/python'} 03:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:05 INFO - Running setup.py (path:/tmp/pip-6JiW7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:05 INFO - Running setup.py (path:/tmp/pip-g6MwAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:05 INFO - Running setup.py (path:/tmp/pip-FanI7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:05 INFO - Running setup.py (path:/tmp/pip-qDI02g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:05 INFO - Running setup.py (path:/tmp/pip-ROVxen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:05 INFO - Running setup.py (path:/tmp/pip-vJ8hyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:05 INFO - Running setup.py (path:/tmp/pip-ddJmot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:05 INFO - Running setup.py (path:/tmp/pip-BQWndV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:05 INFO - Running setup.py (path:/tmp/pip-2wpEru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:05 INFO - Running setup.py (path:/tmp/pip-iG1cEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:05 INFO - Running setup.py (path:/tmp/pip-649pOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:05 INFO - Running setup.py (path:/tmp/pip-cA8ERE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:05 INFO - Running setup.py (path:/tmp/pip-j5BmTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:05 INFO - Running setup.py (path:/tmp/pip-ZigAp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:06 INFO - Running setup.py (path:/tmp/pip-QeX1A7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:06 INFO - Running setup.py (path:/tmp/pip-Eb9o9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:06 INFO - Running setup.py (path:/tmp/pip-7fDpjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:06 INFO - Running setup.py install for manifestparser 03:19:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:19:06 INFO - Running setup.py install for mozcrash 03:19:06 INFO - Running setup.py install for mozdebug 03:19:06 INFO - Running setup.py install for mozdevice 03:19:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:19:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:19:06 INFO - Running setup.py install for mozfile 03:19:06 INFO - Running setup.py install for mozhttpd 03:19:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:19:06 INFO - Running setup.py install for mozinfo 03:19:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:19:06 INFO - Running setup.py install for mozInstall 03:19:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Running setup.py install for mozleak 03:19:07 INFO - Running setup.py install for mozlog 03:19:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Running setup.py install for moznetwork 03:19:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Running setup.py install for mozprocess 03:19:07 INFO - Running setup.py install for mozprofile 03:19:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Running setup.py install for mozrunner 03:19:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Running setup.py install for mozscreenshot 03:19:07 INFO - Running setup.py install for moztest 03:19:07 INFO - Running setup.py install for mozversion 03:19:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:19:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:07 INFO - Cleaning up... 03:19:08 INFO - Return code: 0 03:19:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:19:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:19:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:08 INFO - Using env: {'DISPLAY': ':0', 03:19:08 INFO - 'HOME': '/home/cltbld', 03:19:08 INFO - 'LANG': 'en_US.UTF-8', 03:19:08 INFO - 'LANGUAGE': 'en_US:en', 03:19:08 INFO - 'LOGNAME': 'cltbld', 03:19:08 INFO - 'MAIL': '/var/mail/cltbld', 03:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:08 INFO - 'MOZ_NO_REMOTE': '1', 03:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:08 INFO - 'NO_EM_RESTART': '1', 03:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:08 INFO - 'SHELL': '/bin/bash', 03:19:08 INFO - 'SHLVL': '1', 03:19:08 INFO - 'TERM': 'linux', 03:19:08 INFO - 'TMOUT': '86400', 03:19:08 INFO - 'USER': 'cltbld', 03:19:08 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:08 INFO - '_': '/tools/buildbot/bin/python'} 03:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:08 INFO - Running setup.py (path:/tmp/pip-81IlAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:08 INFO - Running setup.py (path:/tmp/pip-U2KHT9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:08 INFO - Running setup.py (path:/tmp/pip-1wFuwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:08 INFO - Running setup.py (path:/tmp/pip-mirgZi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:08 INFO - Running setup.py (path:/tmp/pip-hHN144-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:08 INFO - Running setup.py (path:/tmp/pip-JY1yBh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:08 INFO - Running setup.py (path:/tmp/pip-1bsmlo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:08 INFO - Running setup.py (path:/tmp/pip-lowlRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:08 INFO - Running setup.py (path:/tmp/pip-_6qCBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:08 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)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:08 INFO - Running setup.py (path:/tmp/pip-c6rhqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:08 INFO - Running setup.py (path:/tmp/pip-iOw748-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:09 INFO - Running setup.py (path:/tmp/pip-hhKZav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:09 INFO - Running setup.py (path:/tmp/pip-r1OlsO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:09 INFO - Running setup.py (path:/tmp/pip-iJmnu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:09 INFO - Running setup.py (path:/tmp/pip-0_jyEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:09 INFO - Running setup.py (path:/tmp/pip-fUlxLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:09 INFO - Running setup.py (path:/tmp/pip-xo7rmu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:09 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)) 03:19:09 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)) 03:19:09 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)) 03:19:09 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)) 03:19:09 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)) 03:19:09 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)) 03:19:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:09 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 03:19:09 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 03:19:09 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 03:19:09 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 03:19:09 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 03:19:09 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 03:19:11 INFO - Downloading blessings-1.5.1.tar.gz 03:19:11 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:19:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:11 INFO - Installing collected packages: blessings 03:19:11 INFO - Running setup.py install for blessings 03:19:11 INFO - Successfully installed blessings 03:19:11 INFO - Cleaning up... 03:19:11 INFO - Return code: 0 03:19:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:19:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:19:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:19:11 INFO - Reading from file tmpfile_stdout 03:19:11 INFO - Current package versions: 03:19:11 INFO - argparse == 1.2.1 03:19:11 INFO - blessings == 1.5.1 03:19:11 INFO - blobuploader == 1.2.4 03:19:11 INFO - docopt == 0.6.1 03:19:11 INFO - manifestparser == 1.1 03:19:11 INFO - mozInstall == 1.12 03:19:11 INFO - mozcrash == 0.16 03:19:11 INFO - mozdebug == 0.1 03:19:11 INFO - mozdevice == 0.47 03:19:11 INFO - mozfile == 1.2 03:19:11 INFO - mozhttpd == 0.7 03:19:11 INFO - mozinfo == 0.9 03:19:11 INFO - mozleak == 0.1 03:19:11 INFO - mozlog == 3.1 03:19:11 INFO - moznetwork == 0.27 03:19:11 INFO - mozprocess == 0.22 03:19:11 INFO - mozprofile == 0.27 03:19:11 INFO - mozrunner == 6.11 03:19:11 INFO - mozscreenshot == 0.1 03:19:11 INFO - mozsystemmonitor == 0.0 03:19:11 INFO - moztest == 0.7 03:19:11 INFO - mozversion == 1.4 03:19:11 INFO - psutil == 3.1.1 03:19:11 INFO - requests == 1.2.3 03:19:11 INFO - wsgiref == 0.1.2 03:19:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19: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')]} 03:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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', '-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 0x7f59321d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', '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 03:19:11 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 03:19:11 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 03:19:11 INFO - Using env: {'DISPLAY': ':0', 03:19:11 INFO - 'HOME': '/home/cltbld', 03:19:11 INFO - 'LANG': 'en_US.UTF-8', 03:19:11 INFO - 'LANGUAGE': 'en_US:en', 03:19:11 INFO - 'LOGNAME': 'cltbld', 03:19:11 INFO - 'MAIL': '/var/mail/cltbld', 03:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:11 INFO - 'MOZ_NO_REMOTE': '1', 03:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:11 INFO - 'NO_EM_RESTART': '1', 03:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:11 INFO - 'SHELL': '/bin/bash', 03:19:11 INFO - 'SHLVL': '1', 03:19:11 INFO - 'TERM': 'linux', 03:19:11 INFO - 'TMOUT': '86400', 03:19:11 INFO - 'USER': 'cltbld', 03:19:11 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:11 INFO - '_': '/tools/buildbot/bin/python'} 03:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 INFO - Cleaning up... 03:19:11 INFO - Return code: 0 03:19:11 INFO - Running post-action listener: _resource_record_post_action 03:19:11 INFO - Running post-action listener: _start_resource_monitoring 03:19:11 INFO - Starting resource monitoring. 03:19:11 INFO - ##### 03:19:11 INFO - ##### Running install step. 03:19:11 INFO - ##### 03:19:11 INFO - Running pre-action listener: _resource_record_pre_action 03:19:11 INFO - Running main action method: install 03:19:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:19:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:19:12 INFO - Reading from file tmpfile_stdout 03:19:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:19:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:19:12 INFO - Reading from file tmpfile_stdout 03:19:12 INFO - Output received: 03:19:12 INFO - Usage: mozinstall [options] installer 03:19:12 INFO - Options: 03:19:12 INFO - -h, --help show this help message and exit 03:19:12 INFO - -d DEST, --destination=DEST 03:19:12 INFO - Directory to install application into. [default: 03:19:12 INFO - "/builds/slave/test-pgo"] 03:19:12 INFO - --app=APP Application being installed. [default: firefox] 03:19:12 INFO - mkdir: /builds/slave/test-pgo/build/application 03:19:12 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'] 03:19:12 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 03:19:26 INFO - Reading from file tmpfile_stdout 03:19:26 INFO - Output received: 03:19:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:19:26 INFO - Running post-action listener: _resource_record_post_action 03:19:26 INFO - ##### 03:19:26 INFO - ##### Running run-tests step. 03:19:26 INFO - ##### 03:19:26 INFO - Running pre-action listener: _resource_record_pre_action 03:19:26 INFO - Running main action method: run_tests 03:19:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:19:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:19:26 INFO - Python 2.7.3 03:19:26 INFO - Return code: 0 03:19:26 INFO - grabbing minidump binary from tooltool 03:19:26 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')]} 03:19:26 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 0x1733d70>, '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 0x1734b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1734fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:19:26 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 03:19:26 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 03:19:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:26 INFO - Return code: 0 03:19:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:19:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:19:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:19:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:19:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:19:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:19:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 03:19:26 INFO - Using env: {'DISPLAY': ':0', 03:19:26 INFO - 'HOME': '/home/cltbld', 03:19:26 INFO - 'LANG': 'en_US.UTF-8', 03:19:26 INFO - 'LANGUAGE': 'en_US:en', 03:19:26 INFO - 'LOGNAME': 'cltbld', 03:19:26 INFO - 'MAIL': '/var/mail/cltbld', 03:19:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:19:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:26 INFO - 'MOZ_NO_REMOTE': '1', 03:19:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:26 INFO - 'NO_EM_RESTART': '1', 03:19:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:26 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:19:26 INFO - 'SHELL': '/bin/bash', 03:19:26 INFO - 'SHLVL': '1', 03:19:26 INFO - 'TERM': 'linux', 03:19:26 INFO - 'TMOUT': '86400', 03:19:26 INFO - 'USER': 'cltbld', 03:19:26 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838', 03:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:26 INFO - '_': '/tools/buildbot/bin/python'} 03:19:26 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/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 03:19:27 INFO - mozversion INFO | application_buildid: 20151124023016 03:19:27 INFO - mozversion INFO | application_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 03:19:27 INFO - mozversion INFO | application_display_name: Nightly 03:19:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:27 INFO - mozversion INFO | application_name: Firefox 03:19:27 INFO - mozversion INFO | application_remotingname: firefox 03:19:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:19:27 INFO - mozversion INFO | application_vendor: Mozilla 03:19:27 INFO - mozversion INFO | application_version: 45.0a1 03:19:27 INFO - mozversion INFO | platform_buildid: 20151124023016 03:19:27 INFO - mozversion INFO | platform_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 03:19:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:19:27 INFO - mozversion INFO | platform_version: 45.0a1 03:19:27 INFO - 2015-11-24 03:19:27,093 DEBUG : using testdate: 1448363967 03:19:27 INFO - 2015-11-24 03:19:27,093 DEBUG : actual date: 1448363967 03:19:27 INFO - 2015-11-24 03:19:27,102 INFO : starting webserver on 'localhost:39489' 03:19:27 INFO - 2015-11-24 03:19:27,103 INFO : Starting test suite talos-linux64-ix-060.e 03:19:27 INFO - 2015-11-24 03:19:27,103 INFO : Starting test dromaeo_css 03:19:27 INFO - 2015-11-24 03:19:27,104 DEBUG : operating with platform_type : linux_ 03:19:27 INFO - 2015-11-24 03:19:27,104 INFO : Initialising browser for dromaeo_css test... 03:19:27 INFO - 2015-11-24 03:19:27,121 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDV7BLS/profile http://localhost:39489/getInfo.html 03:19:31 INFO - 2015-11-24 03:19:31,362 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:19:31 INFO - 2015-11-24 03:19:31,363 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:19:31 INFO - 2015-11-24 03:19:31,363 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:19:31 INFO - 2015-11-24 03:19:31,363 DEBUG : BROWSER_OUTPUT: __metrics 03:19:32 INFO - 2015-11-24 03:19:32,385 INFO : Browser initialized. 03:19:32 INFO - 2015-11-24 03:19:32,386 INFO : Running cycle 1/1 for dromaeo_css test... 03:19:32 INFO - 2015-11-24 03:19:32,386 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDV7BLS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:19:44 INFO - 2015-11-24 03:19:44,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 140349440 03:19:44 INFO - 2015-11-24 03:19:44,225 DEBUG : BROWSER_OUTPUT: 03:20:33 INFO - 2015-11-24 03:20:33,840 DEBUG : BROWSER_OUTPUT: 1448364033838 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] 03:22:43 INFO - 2015-11-24 03:22:43,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39489/tests/dromaeo/cssquery-ext.html) 03:22:44 INFO - 2015-11-24 03:22:44,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 144052224 03:22:44 INFO - 2015-11-24 03:22:44,874 DEBUG : BROWSER_OUTPUT: 03:25:46 INFO - 2015-11-24 03:25:46,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/dromaeo/cssquery-ext.html (next: http://localhost:39489/tests/dromaeo/cssquery-jquery.html) 03:25:47 INFO - 2015-11-24 03:25:47,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 144494592 03:25:47 INFO - 2015-11-24 03:25:47,411 DEBUG : BROWSER_OUTPUT: 03:28:49 INFO - 2015-11-24 03:28:49,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39489/tests/dromaeo/cssquery-mootools.html) 03:28:49 INFO - 2015-11-24 03:28:49,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 142909440 03:28:49 INFO - 2015-11-24 03:28:49,659 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2015-11-24 03:31:51,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39489/tests/dromaeo/cssquery-prototype.html) 03:31:51 INFO - 2015-11-24 03:31:51,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 141537280 03:31:51 INFO - 2015-11-24 03:31:51,917 DEBUG : BROWSER_OUTPUT: 03:34:54 INFO - 2015-11-24 03:34:54,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39489/tests/dromaeo/cssquery-yui.html) 03:34:54 INFO - 2015-11-24 03:34:54,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 03:34:54 INFO - 2015-11-24 03:34:54,868 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/dromaeo/cssquery-yui.html (next: http://localhost:39489/tests/dromaeo/cssquery-dojo.html) 03:37:57 INFO - 2015-11-24 03:37:57,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 144445440 03:37:57 INFO - 2015-11-24 03:37:57,323 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,323 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:37:57 INFO - 2015-11-24 03:37:57,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:37:57 INFO - 2015-11-24 03:37:57,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:37:57 INFO - 2015-11-24 03:37:57,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:37:57 INFO - 2015-11-24 03:37:57,324 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3260.559824423703;3311.387393332232;3331.2338162222673;3354.1782263345476;3362.344342853143;5342.946570534294;5485.588580856437;5488.067028605132;5512.614117011811;5526.032944234758;5471.37079235888;5518.172274158878;5548.029094908385;5612.943870561293;5624.943750562493;4992.151334273173;5051.848444546669;5135.435102138762;5158.7936482540845;5161.303224064741;5038.269450929632;5111.744412779365;5140.691558506483;5150.3047088642925;5169.948300516984;4953.257011448276;4967.403911530603;5097.923531147036;5104.132297509433;5118.436971933084;5135.537801597874;5136.357955255593;5136.563392111675;5152.124138896396;5168.018076565478;5108.208227724708;5126.487351264881;5126.5898728101665;5136.1525348317855;5141.485851414866;5194.11700010999;5194.974025129888;5340.679559226459;5368.953054154442;5439.564834813205;6040.939590604125;6068.180795592582;6073.969630151821;6086.7565297388055;6101.328853826076;6065.545084118665;6094.268687757498;6102.054181601814;6117.051856962178;6117.541184411187;5488.53347465466;5571.804986825442;5581.6371935824045;5634.408387119375;5668.0647693130995;6167.814965551041;6199.225096862892;6214.2542894852;6217.4715149212825;6226.097215903668;5702.800401985911;6016.947034268986;6023.939760602426;6024.126501657235;6047.455728984412;5923.111533270044;5990.820275391745;6022.5483088768515;6024.246969128859;6029.758809647565;5920.437558431942;5941.287045554561;5957.1362152487645;5987.670678112659;6060.575759696779;5993.160957465958;6041.063635136561;6045.183900173508;6060.818175454743;6072.51419886408;4445.444319460067;4632.768361581908;4636.9536304637195;4638.373819534387;4649.651276154302;4043.292423825819;4055.1078762672164;4070.578006086374;4086.1827634473225;4131.5455299916985;5637.802676906289;5714.285714285715;5715.514181294553;5727.284089488814;5797.710114494343;5876.7649294028615;5948.821535353946;6024.457798798129;6037.969810150921;6039.7282122304605;5605.32736071674;5658.094704847287;5684.488396044376;5690.5447564194765;5742.425757424307;5212;5239.973800130975;5243.239730239094;5262.631615786935;5287.206918962186;6021.337652858182;6077.301110372364;6116.418940200674;6214.285357183891;6246.500279977591;5979.790707325223;6030.728617212324;6068.241469816273;6069.726862291119;6111.95640283616;6144.938550614436;6172.722227499684;6204.751809927552;6216.937830621636;6222.782202622887;5768.769249229984;5844.357120716632;5906.143609176731;5909.674967876808;5924.318703348998;5872.706364681834;5930.436608522184;5938.317093534126;5939.049752039653;5981.880362392815;5911.408859114226;5946.43508866657;5956.731947062306;5969.641821490724;5997.730102145501;5886.529077673861;5923.992921203492;5943.970280148572;5946;5956.76172953077;5590.944090559043;5713.285839270091;5758.395368486416;5844.298684157929;5895.498882594856;5926.288845338415;5946.464818166386;5979.940200598112;6017.488513476404;6018.428249316308;5773.076307790733;5800.854978625568;5814.069748840166;5820.563457740602;5827.562932779973 03:37:57 INFO - 2015-11-24 03:37:57,327 DEBUG : BROWSER_OUTPUT: |1;ext.html;576.2882839692978;576.7750577274863;585.373650194292;587.3216435017554;590.391896346763;40303.19393612129;41423.378649320206;41432.17135657285;41480;41810.163796724046;43948;44384.77807610966;44681.329780053245;44883;44909.775451122696;8766.956165219164;8883.200511953923;8910.064443233432;8934.240589549896;8936.151065648786;8717.825643487127;8839;8853.42452740573;8855.867161992575;8861.335399845006;8820.823583528325;8839.46963182211;8890.73327800167;8908.777280567972;8917.509536975464;8818.559072046404;8821.691240806542;8856.778580535474;8868.492356299445;8892.644294228223;8649.048604653482;8768.298536117096;8796.032436431988;8800.647974081028;8806.075362086953;39494.80252598719;39696.80151599253;39814.20371592552;39905.80047099775;40066;2859.8570071496342;3215.839208039612;3298.1259966109;3343.114074770188;3380.408428525023;29416.411671766444;29800.701992980008;30258;30346.965303469697;31218.53172202419;3696.057505336149;3697.4638677391627;3762.7366084374103;3765.661090501868;3799.069228039148;248329;248509.7574512134;249116;250000;250369;53143;54003;67711.66144169346;69349.30650693529;69359.30640693629;61680.07479887805;61826.69086654538;62251;62253;62306;15772.211389430711;15874.285657145456;15904.920475397548;15928.123953182454;15964;11966.341851198094;11986.46060927243;12000.099992500423;12112.39438028095;12114.57708458312;20232.494187645134;20282.391528254175;20544.897275513827;20618.896905515376;20668.17327306921;7522.435817313723;7684.231576842383;7717.614119294013;7776.377889768805;7807.921920780833;949.1742184299703;951.9000504946881;985.7437066362797;1027.121810851711;1044.2481413382352;26689.3327666806;27236.863815680794;27529.44941101207;27724.30689232785;27877.303067423072;1016.6340117557673;1054.878688950765;1067.0929709746654;1093.8906109389156;1101.388729255255;14268.500602478864;14430.474666933245;14490;14583.002225047663;14860.777088343684;291673;295154;296760;297337;298005;52501.47498524966;52518.47481525212;52572.21141682878;52603.73698131561;52687.473125269025;1340.6380277325068;1350.3653282956996;1350.6420798488605;1363.3319673360181;1376.9105008174436;25379;27146.457070858076;27565.310867227676;27609.723902761518;27805.165845024683;48819;49386.506134938194;49490.25764613606;49561.25658115059;49766.751166243936;253102;253857;254811;255523;256085;31177;31675;31783;31944.840275798473;32089.83955080303;37832.243355133294;38424.80787596044;38603.80698096492;38689.80655096706;38718.22563548657;31411.52882706807;33004.17489562684;34216.657833422345;35198.29603407866;35736.463953041246;33707.83146084352;33789.32421351608;33911.152221194665;34106;34163.829180853936;33588.1602959928;33619.15952101119;33911.83044084862;34093.31813363669;34225.82887085548;30691.079267622008;32897.342053158325;33326.500102497994;33406;33641.66358336385;25235.74764252334;25984.480310394065;25995.87002065053;26083.478330432907;26166.73833261719 03:37:57 INFO - 2015-11-24 03:37:57,328 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.50192479566203;356.6789889099812;358.19406335744577;358.39968053510364;363.37499500858524;16455.75316370254;16738.246778894947;17266.395676151336;17390.739138912893;18027.4591762247;10744.677659670202;10747.08649764769;11129.944350278258;11139.830317816633;11139.888601114008;4817.084753896748;4841.3464182335465;4893.608511319104;4923.9753801230945;4940.1601727706375;4863.8784030399165;4890.608751299906;4909.484504127069;4910.06708725341;4911.140550403683;4897.706137631753;4898.951010489903;5037.722925239111;5164.922526162091;5207.791688332462;5067.366579177566;5142.588592912558;5153.922691159635;5156.664816786915;5160.948390516084;5128.102582048164;5158.200478925735;5168.508991645787;5174.404943431516;5174.844754657366;12122.272663640122;12277.877221227764;12490.81263781044;12525.749485010248;12532.624021279376;1992.481954691776;2016.616842799878;2114.947126321839;2122.0875023739786;2169.566086782634;9373.06269373064;9460.290478214092;9478.90521094794;10131.392116472962;13409.128406653535;1822.134486119096;1841.1806745998035;1847.9260829566936;1875.9718604220948;1905.1807722679243;58474;59697.403025969616;59928;62215.688921555105;63310;9936.751581210383;10228.28402011852;10231.897681023094;10292.485375731183;10349.172066234683;12890.677733056562;12948.935255323851;13576.660583485294;13614.659633509242;13628.182309061489;5814.447627475383;5836.328822185503;6582.341765823379;7381.630918454056;7391.2978267064545;7159.212486626467;7174.892376614355;7186.353228209487;7212.3869471094495;7223.349898509159;4375.781210939504;4390.1878152541885;4446.933296000562;4461.063176732858;4465.307877279027;1818.3181307009872;1840;1844.97232541512;1869.560653246486;1872.700367941123;855.6149732620346;881.5548148185126;930.692871352452;999.2954966748425;1041.3335465302212;15893.284802183929;16195.757063644054;16846.14692383837;17270.740938885927;17282.04948727807;888.1695614600369;936.2884208001832;981.0336818234034;999.4403134244847;1040.7970445763003;7167.569945803269;9525.71402860605;9602.711918642452;9614.278929080347;9655.986121457287;500879;502090;508048;508471;519230;78667.60666196747;80246.5987670058;80631.19368806355;81325.18674813176;81745.59127204445;1177.3877583656451;1179.2099293473393;1231.2858542045592;1233.993830030862;1256.5036810459999;15156.545303640909;15340.30968606393;15357.923210383877;15364.385424582892;15552.533423997298;34605.653943460246;34635.65364346324;34984.650153498136;35375;36302.09244768902;46583.301250480596;47022;47424.7628761854;47776.28335575038;50812.491875082254;9425.858612120686;9492;9583.616655333708;9612.423254604746;9659.082387173208;11696.941515292368;17183.914080429517;17503;17805.287788488316;18190.818091818914;12937.870621293667;13624.93187534056;13657.38541765603;13889.097208681404;14266.215358155401;13731.313434328444;13750.312484375941;13939.860601393857;14471;14486.710265794836;13360.198388096745;14036.78944815849;14227.573172804832;14535.636609084435;14548.49080282185;9329.626814927327;9708;9858;9870.358426702242;9924.15644670211;13868.237246951514;14462.795488669432;14694.191819450032;14803.851961480248;15020.924895375454 03:37:57 INFO - 2015-11-24 03:37:57,331 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.6384067823712;1665.5336505778382;1727.5249306440735;1736.8610511159109;1738.713112336465;6978.232394436621;7165.964170179155;7793.1817159198245;8013.479123856945;8041.396895232859;7637.73267935621;7752.263534964183;7815.413843961712;7844.803879902991;7859.567723775204;2235.6870038194666;2262.3552287598036;2269.7503274639776;2274.5337205872756;2279.076973825603;2279.384566167142;2304.8847557622134;2306.9653955190684;2307.042577330406;2315.733690625574;2230.7657695941934;2234.486068204314;2260.1976298414074;2262.8076613487874;2275.5448910218024;2241.3276017194858;2258.525709600986;2301.344116926685;2301.7007788987407;2303.0212159832004;2287.1651847075696;2288.2677543186187;2312.861228326289;2313.618252988255;2315.409570559513;7727.922720772776;7769.10655274645;7798.844023119563;7830.882536761953;7850.803729906741;4705.717656940595;4744.572988431058;4791.496892826238;4795.736234507101;4796.8560943171415;3104.5343198520177;3117.9220519486967;3183.761217908643;3205.423023855705;3220.4203243416177;988.1107003696659;1010.4089107871904;1021.9744506387325;1027.3835698580867;1045.2265323660513;10885.346879187275;10910.727231819188;10923.071538919123;10928.945355273252;10955.56177752889;4222.915541689149;4246.5116511600945;4279.186954478639;4293.785310734451;4294.055307832272;9353.39202951806;9379.390339627902;9381.343305968654;9405;9406.90593094074;4697.224957881979;4724.456687480983;4727.929081063787;4742.07529531738;4759.571638552547;4301.333293339538;4310.030243195319;4314.180305741899;4382.890427739332;4386.4736231652405;3697.408414653696;3715.0898029982827;3748.700103991674;3751.437284407361;3775.8867233983024;1221.6090850927797;1233.4018001269378;1237.5915947737226;1238.6346027921604;1240.3364200152876;1294.2622705058027;1296.1445446005591;1305.3603734170188;1316.5128902306208;1332;7122.287771222836;7138.750143745048;7141.785746427616;7231.385332246818;7386.852262954711;477.5701868318472;483.35954859810187;489.50559934466446;491.1184423959002;492.2394899879694;5727.31272247333;5727.3699893011735;5757.712114394263;5761.48146666802;5771.192033115367;8852.557372131369;9288.071192880792;9338.719838404722;9389.154976052188;9418.434893906251;9171.63313467454;9303.534823258946;9344.112309330603;9361.157495825408;9379.155875971195;7026.92973070273;7138.892916606255;7144.392726618192;7166.319199676022;7202.423806095605;7105.25394833535;7107.928920710933;7150.284971503016;7179;7188.065551478484;7970.681172753025;8235.052968908652;8302.252797248277;8313.251807337369;8346.374021948499;8513.489190648581;8528.957355213184;8535.231829135408;8581.442206256574;8693.34799889998;5969.462748352669;6177.073438984188;6502.967485162544;6723.394894459522;6956.513044086865;7647.9235207649435;7655.1962043986805;7684.500507466997;7703.961480192564;7705.30652241301;6955.478339124687;7017.473689473208;7068.893966590608;7225.313595208447;7295.744648937261;7001.194862590867;7082.362587367162;7111.324424179695;7196.820079498055;7235.023271858232;7057.188423331382;7083.256258092826;7177.748778792926;7191.17301510333;7193.064901562763;6607.141071660653;6620.966895165493;6657.700403481952;6708.19501659804;6712.630805305755;6477.740890364333;6500.967495162494;6522.510811689237;6680.933190668031;6749.831254218488 03:37:57 INFO - 2015-11-24 03:37:57,331 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.4541166487807;318.0966056399824;324.1313280408505;328.1337269608233;331.1456442378662;6251.843703907404;6339.7464101436;6353.777617783373;6390.424861762441;6496.837579060514;6249.406306400896;6293.213348331458;6293.244810622732;6305.779297724581;6311.431971122598;4539.046800171951;4651.418572678415;4653.88365290867;4718.74046927418;4734.9763251183695;4689.859304220879;4697.53024697531;4709.2229782085915;4713.104510143079;4725.10223057618;4643.2802915548145;4647.837325693601;4659.53404659533;4660.277656963176;4661.86014419568;4647.14027904837;4653.162430762462;4662.090892276007;4677.532246775329;4688.624910007191;3923.2153569286256;3998.6401223889698;4006.379011253231;4012.2376748417705;4016.2971479990883;5889.352171261158;5908.67502287374;5915.378885217034;5917.911231331534;5921.259842519685;5398.406175320712;5423.701696406696;5428.809991650273;5440.755166017539;5456.372517160537;6568.967155164193;6575.342465753434;6583.934160658428;6588.077669126278;6600.537962342638;4346.456692913386;4441.844535441244;4449.555044495557;4451.399061126739;4452.933206001912;6826.385625293698;6845.828854278633;6870.072540207058;6900.930990690079;6916.619585922772;4499.797509112098;4538.683781703335;4543.432070991126;4544.500104988449;4553.089382123522;4498.550144985541;4580.7938642761155;4589.58693717567;4595.793189306489;4596.747178905125;5433.864153396117;5434.049041417815;5436.83689489308;5439.755211015514;5443.510084092451;6685.598864068172;6702.09521714572;6707.966460167766;6718.8320291993095;6719.462443004548;1627.1701432269629;1645.6708658268155;1648.2253340929744;1650.191406210948;1650.3233674193764;1062.166199533378;1076.036946932491;1077.28898926708;1082.8213344798178;1082.8917108289265;6379.425851673372;6436.678166091677;6457.418832305115;6466;6469.029645553204;6974.093367862146;6992.1958974717545;6994.440444764508;6998.580085194904;7005.649717514104;6524.641144737085;6542.967285163544;6552.180977377828;6552.3447655234095;6556.803295901131;3700.888973330804;3774.0753515388906;3783.319002579507;3796.1648437343742;3805.771653700787;7243;7260.165081015751;7266.237045110293;7267.63661816907;7270.600116993511;7133.536320139175;7165.96417017922;7170.354668079898;7174.928250717426;7186.850103983337;7090.397316228178;7222;7250.129984401906;7264.164621068433;7270.527415717961;6904.067950826574;6910.894256918868;6914.343137401939;6967.372936435745;6976.930230697831;6851.588904665736;6886.896696549456;6890.827729306808;6901.89647155283;6907.896381554381;7025.929740702528;7256.818579535554;7257.854842903007;7262.782116536512;7269.890951635624;4601.217792975269;4619.284010978304;4638.53614638547;4649.093426781745;4651.604613607881;6862.656867156722;6887.896681549681;6937.167539895245;6949.235584085645;6971.755988540377;6644.169478815148;6726.461883049442;6732.394084532416;6755.763548275787;6766.086578311865;6757.358050985148;6759.763408280686;6765.594064356154;6773.729050838108;6785.5911151540495;6479.676016199077;6608;6627.271000190071;6629.43649789754;6653.800385988428;6518.641474718746;6693.364130407604;6767.89848152288;6787;6787.5588086774205;6403.551751377358;6596.571222870498;6627.304133066152;6634.800955971328;6644.136262285871 03:37:57 INFO - 2015-11-24 03:37:57,335 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.7886455198889;734.9485536012479;748.9925100748994;776.6776787633129;826.3224156191925;13227.272500012496;13468;13488.393022313994;13527.25600091997;13561.32193390329;12358.38208089594;12416.689582760413;12424.130310878241;12435.875641243585;12443.253404795718;817.6770175780563;832.4381042796118;834.3658819297317;835.0605568735173;836.7406104107715;829.1956801902145;840.2941529115542;840.7099550655045;841.7180244618061;847.8007668197969;860.9182127697859;866.2680035370103;869.2481003931617;870.3211495033884;872.0451106038877;858.9226969572737;865.208334374047;865.7446053414258;867.2411639815161;868.9913100868973;634.7619642634012;636.8439732265624;636.9172007639023;637.6556659403916;638.084348959245;13887.375068121959;13971.930140349335;13982.720345593132;14057.789133162909;14092.577222683336;10722.678319650346;10845;11950;12109.636710898687;12305.323207223599;10302.227332949984;10346.793064138676;10348.58605655773;10389.168866490738;10402.271840971134;3456.084137703511;3474.5656792900886;3488.89533314001;3526.0832183632183;3544.9645503544893;48737;49352.75323623395;49375;49454.50545494535;49474;9230.86153707695;9574;10132.645357412455;10235.539400726986;10252.948735256276;16754.58113547171;16768.161591920354;16791.748123778154;16848.663026739396;16864.325426982785;6729.764458243938;7496.062992125984;7670.057104735176;7747.961260193776;7806.219378062148;4417.558244175621;4439.778011099432;4472.932906006413;4482.887927801766;4514.322851572225;3058.2201538607956;3060.32672811981;3065.3409516953516;3066.8313242771414;3067.8772849085785;546.1398297681168;559.8348487196287;570.4010788671878;573.7905664432452;575.0368133376578;622.5113286070413;633.3539789414863;635.6154526511394;668.6690088406173;721.3219573600799;8926.598303076376;8935.106489351012;8996.370254082152;9026.909730902738;9202.81594368109;551.3561582925729;611.3580740222749;662.7779693802534;690.4993879437368;701.4703898556558;4092.856750013735;4148.253314403436;4211.347241177622;4275.337322714984;4386.890327741832;56519.43480565141;57568.13647795287;57688.71155644195;58286.708566456895;58371;52072.73963630158;52218.95044169064;52906;53375.199372009454;53453.465465344845;45977.540224597324;46245.53754462547;46675.76662116668;46889.29666055012;46900.5309946903;8436.11420800807;8527.763474296069;8560.614772335384;8582.570871456526;8621.180987806149;34506.482402763475;35024.12439688926;35450.82274588611;35489.11277217987;35643.82178089093;41756.58243417527;44126.11747765091;45216.32175517304;45233.32150017686;45685.31472027989;10260.794784104426;10337.638182663572;10448.634297799541;10544.15646748243;10802.945985270024;11091.279066860629;11207.383593902088;11393.373364465035;11395.658130256106;11693.590724324607;9924.206063515046;9975.251856110675;10245.590176392861;10272.435016073889;10772.407517586607;10198.694039178836;10206.846897296695;10386.584536618451;10704.625338113128;10857.457127143452;10427.374357538269;10501.89498105009;10512.632057877938;10568.154547636017;10633.096186824207;9103.772405689911;9130.178283954476;9137.131972462605;9359.39163954368;9545.522723863918;9056.864147037668;9294.674686385944;9377.859332109887;9446.905530944603;9448.48033358172 03:37:57 INFO - 2015-11-24 03:37:57,335 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:37:57 INFO - 2015-11-24 03:37:57,335 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:37:57 INFO - 2015-11-24 03:37:57,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,292 03:37:57 INFO - 2015-11-24 03:37:57,336 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:37:57 INFO - 2015-11-24 03:37:57,336 DEBUG : BROWSER_OUTPUT: __startTimestamp1448365077320__endTimestamp 03:37:57 INFO - 2015-11-24 03:37:57,336 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,337 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:37:57 INFO - 2015-11-24 03:37:57,337 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:37:57 INFO - 2015-11-24 03:37:57,337 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,337 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5577.86 Median:5814.07 stddev:632.74 (10.9%) stddev-sans-first:608.00 03:37:57 INFO - 2015-11-24 03:37:57,338 DEBUG : BROWSER_OUTPUT: Values: 3260.6 3311.4 3331.2 3354.2 3362.3 5342.9 5485.6 5488.1 5512.6 5526.0 5471.4 5518.2 5548.0 5612.9 5624.9 4992.2 5051.8 5135.4 5158.8 5161.3 5038.3 5111.7 5140.7 5150.3 5169.9 4953.3 4967.4 5097.9 5104.1 5118.4 5135.5 5136.4 5136.6 5152.1 5168.0 5108.2 5126.5 5126.6 5136.2 5141.5 5194.1 5195.0 5340.7 5369.0 5439.6 6040.9 6068.2 6074.0 6086.8 6101.3 6065.5 6094.3 6102.1 6117.1 6117.5 5488.5 5571.8 5581.6 5634.4 5668.1 6167.8 6199.2 6214.3 6217.5 6226.1 5702.8 6016.9 6023.9 6024.1 6047.5 5923.1 5990.8 6022.5 6024.2 6029.8 5920.4 5941.3 5957.1 5987.7 6060.6 5993.2 6041.1 6045.2 6060.8 6072.5 4445.4 4632.8 4637.0 4638.4 4649.7 4043.3 4055.1 4070.6 4086.2 4131.5 5637.8 5714.3 5715.5 5727.3 5797.7 5876.8 5948.8 6024.5 6038.0 6039.7 5605.3 5658.1 5684.5 5690.5 5742.4 5212.0 5240.0 5243.2 5262.6 5287.2 6021.3 6077.3 6116.4 6214.3 6246.5 5979.8 6030.7 6068.2 6069.7 6112.0 6144.9 6172.7 6204.8 6216.9 6222.8 5768.8 5844.4 5906.1 5909.7 5924.3 5872.7 5930.4 5938.3 5939.0 5981.9 5911.4 5946.4 5956.7 5969.6 5997.7 5886.5 5924.0 5944.0 5946.0 5956.8 5590.9 5713.3 5758.4 5844.3 5895.5 5926.3 5946.5 5979.9 6017.5 6018.4 5773.1 5800.9 5814.1 5820.6 5827.6 03:37:57 INFO - 2015-11-24 03:37:57,338 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,338 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44256.90 Median:34099.66 stddev:69693.88 (204.4%) stddev-sans-first:69812.22 03:37:57 INFO - 2015-11-24 03:37:57,338 DEBUG : BROWSER_OUTPUT: Values: 576.3 576.8 585.4 587.3 590.4 40303.2 41423.4 41432.2 41480.0 41810.2 43948.0 44384.8 44681.3 44883.0 44909.8 8767.0 8883.2 8910.1 8934.2 8936.2 8717.8 8839.0 8853.4 8855.9 8861.3 8820.8 8839.5 8890.7 8908.8 8917.5 8818.6 8821.7 8856.8 8868.5 8892.6 8649.0 8768.3 8796.0 8800.6 8806.1 39494.8 39696.8 39814.2 39905.8 40066.0 2859.9 3215.8 3298.1 3343.1 3380.4 29416.4 29800.7 30258.0 30347.0 31218.5 3696.1 3697.5 3762.7 3765.7 3799.1 248329.0 248509.8 249116.0 250000.0 250369.0 53143.0 54003.0 67711.7 69349.3 69359.3 61680.1 61826.7 62251.0 62253.0 62306.0 15772.2 15874.3 15904.9 15928.1 15964.0 11966.3 11986.5 12000.1 12112.4 12114.6 20232.5 20282.4 20544.9 20618.9 20668.2 7522.4 7684.2 7717.6 7776.4 7807.9 949.2 951.9 985.7 1027.1 1044.2 26689.3 27236.9 27529.4 27724.3 27877.3 1016.6 1054.9 1067.1 1093.9 1101.4 14268.5 14430.5 14490.0 14583.0 14860.8 291673.0 295154.0 296760.0 297337.0 298005.0 52501.5 52518.5 52572.2 52603.7 52687.5 1340.6 1350.4 1350.6 1363.3 1376.9 25379.0 27146.5 27565.3 27609.7 27805.2 48819.0 49386.5 49490.3 49561.3 49766.8 253102.0 253857.0 254811.0 255523.0 256085.0 31177.0 31675.0 31783.0 31944.8 32089.8 37832.2 38424.8 38603.8 38689.8 38718.2 31411.5 33004.2 34216.7 35198.3 35736.5 33707.8 33789.3 33911.2 34106.0 34163.8 33588.2 33619.2 33911.8 34093.3 34225.8 30691.1 32897.3 33326.5 33406.0 33641.7 25235.7 25984.5 25995.9 26083.5 26166.7 03:37:57 INFO - 2015-11-24 03:37:57,339 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,339 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27571.20 Median:360.89 stddev:83108.38 (23028.9%) stddev-sans-first:83316.39 03:37:57 INFO - 2015-11-24 03:37:57,339 DEBUG : BROWSER_OUTPUT: Values: 354.5 356.7 358.2 358.4 363.4 16455.8 16738.2 17266.4 17390.7 18027.5 10744.7 10747.1 11129.9 11139.8 11139.9 4817.1 4841.3 4893.6 4924.0 4940.2 4863.9 4890.6 4909.5 4910.1 4911.1 4897.7 4899.0 5037.7 5164.9 5207.8 5067.4 5142.6 5153.9 5156.7 5160.9 5128.1 5158.2 5168.5 5174.4 5174.8 12122.3 12277.9 12490.8 12525.7 12532.6 1992.5 2016.6 2114.9 2122.1 2169.6 9373.1 9460.3 9478.9 10131.4 13409.1 1822.1 1841.2 1847.9 1876.0 1905.2 58474.0 59697.4 59928.0 62215.7 63310.0 9936.8 10228.3 10231.9 10292.5 10349.2 12890.7 12948.9 13576.7 13614.7 13628.2 5814.4 5836.3 6582.3 7381.6 7391.3 7159.2 7174.9 7186.4 7212.4 7223.3 4375.8 4390.2 4446.9 4461.1 4465.3 1818.3 1840.0 1845.0 1869.6 1872.7 855.6 881.6 930.7 999.3 1041.3 15893.3 16195.8 16846.1 17270.7 17282.0 888.2 936.3 981.0 999.4 1040.8 7167.6 9525.7 9602.7 9614.3 9656.0 500879.0 502090.0 508048.0 508471.0 519230.0 78667.6 80246.6 80631.2 81325.2 81745.6 1177.4 1179.2 1231.3 1234.0 1256.5 15156.5 15340.3 15357.9 15364.4 15552.5 34605.7 34635.7 34984.7 35375.0 36302.1 46583.3 47022.0 47424.8 47776.3 50812.5 9425.9 9492.0 9583.6 9612.4 9659.1 11696.9 17183.9 17503.0 17805.3 18190.8 12937.9 13624.9 13657.4 13889.1 14266.2 13731.3 13750.3 13939.9 14471.0 14486.7 13360.2 14036.8 14227.6 14535.6 14548.5 9329.6 9708.0 9858.0 9870.4 9924.2 13868.2 14462.8 14694.2 14803.9 15020.9 03:37:57 INFO - 2015-11-24 03:37:57,339 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,340 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5472.15 Median:6327.41 stddev:2845.29 (45.0%) stddev-sans-first:2837.66 03:37:57 INFO - 2015-11-24 03:37:57,340 DEBUG : BROWSER_OUTPUT: Values: 1506.6 1665.5 1727.5 1736.9 1738.7 6978.2 7166.0 7793.2 8013.5 8041.4 7637.7 7752.3 7815.4 7844.8 7859.6 2235.7 2262.4 2269.8 2274.5 2279.1 2279.4 2304.9 2307.0 2307.0 2315.7 2230.8 2234.5 2260.2 2262.8 2275.5 2241.3 2258.5 2301.3 2301.7 2303.0 2287.2 2288.3 2312.9 2313.6 2315.4 7727.9 7769.1 7798.8 7830.9 7850.8 4705.7 4744.6 4791.5 4795.7 4796.9 3104.5 3117.9 3183.8 3205.4 3220.4 988.1 1010.4 1022.0 1027.4 1045.2 10885.3 10910.7 10923.1 10928.9 10955.6 4222.9 4246.5 4279.2 4293.8 4294.1 9353.4 9379.4 9381.3 9405.0 9406.9 4697.2 4724.5 4727.9 4742.1 4759.6 4301.3 4310.0 4314.2 4382.9 4386.5 3697.4 3715.1 3748.7 3751.4 3775.9 1221.6 1233.4 1237.6 1238.6 1240.3 1294.3 1296.1 1305.4 1316.5 1332.0 7122.3 7138.8 7141.8 7231.4 7386.9 477.6 483.4 489.5 491.1 492.2 5727.3 5727.4 5757.7 5761.5 5771.2 8852.6 9288.1 9338.7 9389.2 9418.4 9171.6 9303.5 9344.1 9361.2 9379.2 7026.9 7138.9 7144.4 7166.3 7202.4 7105.3 7107.9 7150.3 7179.0 7188.1 7970.7 8235.1 8302.3 8313.3 8346.4 8513.5 8529.0 8535.2 8581.4 8693.3 5969.5 6177.1 6503.0 6723.4 6956.5 7647.9 7655.2 7684.5 7704.0 7705.3 6955.5 7017.5 7068.9 7225.3 7295.7 7001.2 7082.4 7111.3 7196.8 7235.0 7057.2 7083.3 7177.7 7191.2 7193.1 6607.1 6621.0 6657.7 6708.2 6712.6 6477.7 6501.0 6522.5 6680.9 6749.8 03:37:57 INFO - 2015-11-24 03:37:57,340 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,340 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5562.00 Median:6420.11 stddev:1735.81 (27.0%) stddev-sans-first:1695.44 03:37:57 INFO - 2015-11-24 03:37:57,342 DEBUG : BROWSER_OUTPUT: Values: 316.5 318.1 324.1 328.1 331.1 6251.8 6339.7 6353.8 6390.4 6496.8 6249.4 6293.2 6293.2 6305.8 6311.4 4539.0 4651.4 4653.9 4718.7 4735.0 4689.9 4697.5 4709.2 4713.1 4725.1 4643.3 4647.8 4659.5 4660.3 4661.9 4647.1 4653.2 4662.1 4677.5 4688.6 3923.2 3998.6 4006.4 4012.2 4016.3 5889.4 5908.7 5915.4 5917.9 5921.3 5398.4 5423.7 5428.8 5440.8 5456.4 6569.0 6575.3 6583.9 6588.1 6600.5 4346.5 4441.8 4449.6 4451.4 4452.9 6826.4 6845.8 6870.1 6900.9 6916.6 4499.8 4538.7 4543.4 4544.5 4553.1 4498.6 4580.8 4589.6 4595.8 4596.7 5433.9 5434.0 5436.8 5439.8 5443.5 6685.6 6702.1 6708.0 6718.8 6719.5 1627.2 1645.7 1648.2 1650.2 1650.3 1062.2 1076.0 1077.3 1082.8 1082.9 6379.4 6436.7 6457.4 6466.0 6469.0 6974.1 6992.2 6994.4 6998.6 7005.6 6524.6 6543.0 6552.2 6552.3 6556.8 3700.9 3774.1 3783.3 3796.2 3805.8 7243.0 7260.2 7266.2 7267.6 7270.6 7133.5 7166.0 7170.4 7174.9 7186.9 7090.4 7222.0 7250.1 7264.2 7270.5 6904.1 6910.9 6914.3 6967.4 6976.9 6851.6 6886.9 6890.8 6901.9 6907.9 7025.9 7256.8 7257.9 7262.8 7269.9 4601.2 4619.3 4638.5 4649.1 4651.6 6862.7 6887.9 6937.2 6949.2 6971.8 6644.2 6726.5 6732.4 6755.8 6766.1 6757.4 6759.8 6765.6 6773.7 6785.6 6479.7 6608.0 6627.3 6629.4 6653.8 6518.6 6693.4 6767.9 6787.0 6787.6 6403.6 6596.6 6627.3 6634.8 6644.1 03:37:57 INFO - 2015-11-24 03:37:57,342 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,342 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13695.95 Median:47818.77 stddev:16150.86 (33.8%) stddev-sans-first:16166.60 03:37:57 INFO - 2015-11-24 03:37:57,344 DEBUG : BROWSER_OUTPUT: Values: 681.8 734.9 749.0 776.7 826.3 13227.3 13468.0 13488.4 13527.3 13561.3 12358.4 12416.7 12424.1 12435.9 12443.3 817.7 832.4 834.4 835.1 836.7 829.2 840.3 840.7 841.7 847.8 860.9 866.3 869.2 870.3 872.0 858.9 865.2 865.7 867.2 869.0 634.8 636.8 636.9 637.7 638.1 13887.4 13971.9 13982.7 14057.8 14092.6 10722.7 10845.0 11950.0 12109.6 12305.3 10302.2 10346.8 10348.6 10389.2 10402.3 3456.1 3474.6 3488.9 3526.1 3545.0 48737.0 49352.8 49375.0 49454.5 49474.0 9230.9 9574.0 10132.6 10235.5 10252.9 16754.6 16768.2 16791.7 16848.7 16864.3 6729.8 7496.1 7670.1 7748.0 7806.2 4417.6 4439.8 4472.9 4482.9 4514.3 3058.2 3060.3 3065.3 3066.8 3067.9 546.1 559.8 570.4 573.8 575.0 622.5 633.4 635.6 668.7 721.3 8926.6 8935.1 8996.4 9026.9 9202.8 551.4 611.4 662.8 690.5 701.5 4092.9 4148.3 4211.3 4275.3 4386.9 56519.4 57568.1 57688.7 58286.7 58371.0 52072.7 52219.0 52906.0 53375.2 53453.5 45977.5 46245.5 46675.8 46889.3 46900.5 8436.1 8527.8 8560.6 8582.6 8621.2 34506.5 35024.1 35450.8 35489.1 35643.8 41756.6 44126.1 45216.3 45233.3 45685.3 10260.8 10337.6 10448.6 10544.2 10802.9 11091.3 11207.4 11393.4 11395.7 11693.6 9924.2 9975.3 10245.6 10272.4 10772.4 10198.7 10206.8 10386.6 10704.6 10857.5 10427.4 10501.9 10512.6 10568.2 10633.1 9103.8 9130.2 9137.1 9359.4 9545.5 9056.9 9294.7 9377.9 9446.9 9448.5 03:37:57 INFO - 2015-11-24 03:37:57,344 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:37:57 INFO - 2015-11-24 03:37:57,344 DEBUG : BROWSER_OUTPUT: 03:37:57 INFO - 2015-11-24 03:37:57,969 INFO : Browser exited with error code: 0 03:37:57 INFO - 2015-11-24 03:37:57,988 INFO : Completed test dromaeo_css (00:18:30) 03:37:57 INFO - 2015-11-24 03:37:57,988 INFO : Starting test kraken 03:37:57 INFO - 2015-11-24 03:37:57,988 DEBUG : operating with platform_type : linux_ 03:37:57 INFO - 2015-11-24 03:37:57,989 INFO : Initialising browser for kraken test... 03:37:57 INFO - 2015-11-24 03:37:57,995 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMI6C8G/profile http://localhost:39489/getInfo.html 03:38:02 INFO - 2015-11-24 03:38:02,219 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:38:02 INFO - 2015-11-24 03:38:02,219 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:38:02 INFO - 2015-11-24 03:38:02,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:38:02 INFO - 2015-11-24 03:38:02,220 DEBUG : BROWSER_OUTPUT: __metrics 03:38:03 INFO - 2015-11-24 03:38:03,201 INFO : Browser initialized. 03:38:03 INFO - 2015-11-24 03:38:03,202 INFO : Running cycle 1/1 for kraken test... 03:38:03 INFO - 2015-11-24 03:38:03,202 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMI6C8G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:38:15 INFO - 2015-11-24 03:38:15,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 140083200 03:38:15 INFO - 2015-11-24 03:38:15,003 DEBUG : BROWSER_OUTPUT: 03:38:17 INFO - 2015-11-24 03:38:17,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39489/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:18 INFO - 2015-11-24 03:38:18,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 142913536 03:38:18 INFO - 2015-11-24 03:38:18,080 DEBUG : BROWSER_OUTPUT: 03:38:20 INFO - 2015-11-24 03:38:20,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39489/tests/kraken/driver.html?testName=audio-dft) 03:38:21 INFO - 2015-11-24 03:38:21,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 142553088 03:38:21 INFO - 2015-11-24 03:38:21,318 DEBUG : BROWSER_OUTPUT: 03:38:24 INFO - 2015-11-24 03:38:24,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39489/tests/kraken/driver.html?testName=audio-fft) 03:38:24 INFO - 2015-11-24 03:38:24,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 137379840 03:38:24 INFO - 2015-11-24 03:38:24,742 DEBUG : BROWSER_OUTPUT: 03:38:26 INFO - 2015-11-24 03:38:26,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39489/tests/kraken/driver.html?testName=audio-oscillator) 03:38:27 INFO - 2015-11-24 03:38:27,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 137863168 03:38:27 INFO - 2015-11-24 03:38:27,301 DEBUG : BROWSER_OUTPUT: 03:38:29 INFO - 2015-11-24 03:38:29,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:30 INFO - 2015-11-24 03:38:30,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 138944512 03:38:30 INFO - 2015-11-24 03:38:30,101 DEBUG : BROWSER_OUTPUT: 03:38:33 INFO - 2015-11-24 03:38:33,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39489/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:33 INFO - 2015-11-24 03:38:33,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 140132352 03:38:33 INFO - 2015-11-24 03:38:33,749 DEBUG : BROWSER_OUTPUT: 03:38:37 INFO - 2015-11-24 03:38:37,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39489/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:37 INFO - 2015-11-24 03:38:37,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 140476416 03:38:37 INFO - 2015-11-24 03:38:37,720 DEBUG : BROWSER_OUTPUT: 03:38:40 INFO - 2015-11-24 03:38:40,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39489/tests/kraken/driver.html?testName=json-parse-financial) 03:38:41 INFO - 2015-11-24 03:38:41,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 140693504 03:38:41 INFO - 2015-11-24 03:38:41,165 DEBUG : BROWSER_OUTPUT: 03:38:42 INFO - 2015-11-24 03:38:42,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:43 INFO - 2015-11-24 03:38:43,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 03:38:43 INFO - 2015-11-24 03:38:43,326 DEBUG : BROWSER_OUTPUT: 03:38:45 INFO - 2015-11-24 03:38:45,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:45 INFO - 2015-11-24 03:38:45,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 139636736 03:38:45 INFO - 2015-11-24 03:38:45,789 DEBUG : BROWSER_OUTPUT: 03:38:47 INFO - 2015-11-24 03:38:47,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:48 INFO - 2015-11-24 03:38:48,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 139644928 03:38:48 INFO - 2015-11-24 03:38:48,493 DEBUG : BROWSER_OUTPUT: 03:38:50 INFO - 2015-11-24 03:38:50,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:51 INFO - 2015-11-24 03:38:51,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 139730944 03:38:51 INFO - 2015-11-24 03:38:51,543 DEBUG : BROWSER_OUTPUT: 03:38:54 INFO - 2015-11-24 03:38:54,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:54 INFO - 2015-11-24 03:38:54,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 140849152 03:38:54 INFO - 2015-11-24 03:38:54,708 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39489/tests/kraken/driver.html?testName=ai-astar) 03:38:56 INFO - 2015-11-24 03:38:56,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 03:38:56 INFO - 2015-11-24 03:38:56,647 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,650 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;104;113;111;112;122;110;114;110;111 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;166;167;128;151;156;136;165;136 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;161;164;160;164;162;171;162 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;72;72;71;72;73;135;72 03:38:56 INFO - 2015-11-24 03:38:56,651 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;137;95;94;93;136;92;94;135 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;109;110;110;110;110;111;110 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;147;146;148;149;147;146;146;147 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;98;96;96;97;96 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;62;61;63;62;62;62;61;59 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;70;70;69;68;68;69;69 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;88;86;94;85;87;85;95;89;86 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;121;115;121;127;120;121;118;122;135 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;147;151;152;153;151;157;148;150;155 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;67;69;75;70;68;67;67;68;68 03:38:56 INFO - 2015-11-24 03:38:56,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:38:56 INFO - 2015-11-24 03:38:56,653 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:38:56 INFO - 2015-11-24 03:38:56,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,704 03:38:56 INFO - 2015-11-24 03:38:56,653 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:38:56 INFO - 2015-11-24 03:38:56,653 DEBUG : BROWSER_OUTPUT: __startTimestamp1448365136648__endTimestamp 03:38:56 INFO - 2015-11-24 03:38:56,653 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,657 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:38:56 INFO - 2015-11-24 03:38:56,657 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:38:56 INFO - 2015-11-24 03:38:56,657 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,658 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.50 (4.0%) stddev-sans-first:4.73 03:38:56 INFO - 2015-11-24 03:38:56,658 DEBUG : BROWSER_OUTPUT: Values: 110.0 104.0 113.0 111.0 112.0 122.0 110.0 114.0 110.0 111.0 03:38:56 INFO - 2015-11-24 03:38:56,658 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,659 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:14.96 (9.7%) stddev-sans-first:15.76 03:38:56 INFO - 2015-11-24 03:38:56,659 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 166.0 167.0 128.0 151.0 156.0 136.0 165.0 136.0 03:38:56 INFO - 2015-11-24 03:38:56,659 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,659 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:3.02 (1.8%) stddev-sans-first:3.19 03:38:56 INFO - 2015-11-24 03:38:56,660 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 161.0 164.0 160.0 164.0 162.0 171.0 162.0 03:38:56 INFO - 2015-11-24 03:38:56,660 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,660 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:72.50 stddev:19.83 (27.3%) stddev-sans-first:20.93 03:38:56 INFO - 2015-11-24 03:38:56,660 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 72.0 72.0 71.0 72.0 73.0 135.0 72.0 03:38:56 INFO - 2015-11-24 03:38:56,660 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,661 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.00 stddev:20.45 (21.8%) stddev-sans-first:21.19 03:38:56 INFO - 2015-11-24 03:38:56,661 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 137.0 95.0 94.0 93.0 136.0 92.0 94.0 135.0 03:38:56 INFO - 2015-11-24 03:38:56,661 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,661 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 03:38:56 INFO - 2015-11-24 03:38:56,661 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 147.0 146.0 148.0 149.0 147.0 146.0 146.0 147.0 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 97.0 96.0 03:38:56 INFO - 2015-11-24 03:38:56,662 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,663 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 03:38:56 INFO - 2015-11-24 03:38:56,663 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 61.0 59.0 03:38:56 INFO - 2015-11-24 03:38:56,663 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,663 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 03:38:56 INFO - 2015-11-24 03:38:56,663 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 70.0 70.0 69.0 68.0 68.0 69.0 69.0 03:38:56 INFO - 2015-11-24 03:38:56,663 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,664 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.50 stddev:3.71 (4.2%) stddev-sans-first:3.74 03:38:56 INFO - 2015-11-24 03:38:56,664 DEBUG : BROWSER_OUTPUT: Values: 92.0 88.0 86.0 94.0 85.0 87.0 85.0 95.0 89.0 86.0 03:38:56 INFO - 2015-11-24 03:38:56,664 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,664 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:121.50 stddev:5.43 (4.5%) stddev-sans-first:5.76 03:38:56 INFO - 2015-11-24 03:38:56,664 DEBUG : BROWSER_OUTPUT: Values: 122.0 121.0 115.0 121.0 127.0 120.0 121.0 118.0 122.0 135.0 03:38:56 INFO - 2015-11-24 03:38:56,664 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,665 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:151.50 stddev:3.63 (2.4%) stddev-sans-first:3.17 03:38:56 INFO - 2015-11-24 03:38:56,665 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 151.0 152.0 153.0 151.0 157.0 148.0 150.0 155.0 03:38:56 INFO - 2015-11-24 03:38:56,665 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,665 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.49 (3.6%) stddev-sans-first:2.54 03:38:56 INFO - 2015-11-24 03:38:56,666 DEBUG : BROWSER_OUTPUT: Values: 71.0 67.0 69.0 75.0 70.0 68.0 67.0 67.0 68.0 68.0 03:38:56 INFO - 2015-11-24 03:38:56,666 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:38:56 INFO - 2015-11-24 03:38:56,667 DEBUG : BROWSER_OUTPUT: 03:38:57 INFO - 2015-11-24 03:38:57,509 INFO : Browser exited with error code: 0 03:38:57 INFO - 2015-11-24 03:38:57,562 INFO : Completed test kraken (00:00:59) 03:38:57 INFO - 2015-11-24 03:38:57,562 INFO : Starting test v8_7 03:38:57 INFO - 2015-11-24 03:38:57,563 DEBUG : operating with platform_type : linux_ 03:38:57 INFO - 2015-11-24 03:38:57,563 INFO : Initialising browser for v8_7 test... 03:38:57 INFO - 2015-11-24 03:38:57,569 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp27HGDy/profile http://localhost:39489/getInfo.html 03:39:01 INFO - 2015-11-24 03:39:01,704 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:39:01 INFO - 2015-11-24 03:39:01,704 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:39:01 INFO - 2015-11-24 03:39:01,704 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:39:01 INFO - 2015-11-24 03:39:01,704 DEBUG : BROWSER_OUTPUT: __metrics 03:39:02 INFO - 2015-11-24 03:39:02,777 INFO : Browser initialized. 03:39:02 INFO - 2015-11-24 03:39:02,778 INFO : Running cycle 1/1 for v8_7 test... 03:39:02 INFO - 2015-11-24 03:39:02,778 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp27HGDy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:39:14 INFO - 2015-11-24 03:39:14,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 142094336 03:39:14 INFO - 2015-11-24 03:39:14,614 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39489/tests/v8_7/run.html (next: http://localhost:39489/tests/v8_7/run.html) 03:39:36 INFO - 2015-11-24 03:39:36,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 138964992 03:39:36 INFO - 2015-11-24 03:39:36,277 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,278 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:39:36 INFO - 2015-11-24 03:39:36,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: |0;Richards;196.15535504119262 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.01228878648234 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 03:39:36 INFO - 2015-11-24 03:39:36,279 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1067.2358591248667 03:39:36 INFO - 2015-11-24 03:39:36,280 DEBUG : BROWSER_OUTPUT: |5;Earley;698.8120195667366 03:39:36 INFO - 2015-11-24 03:39:36,280 DEBUG : BROWSER_OUTPUT: |6;Boyer;12289.156626506025 03:39:36 INFO - 2015-11-24 03:39:36,280 DEBUG : BROWSER_OUTPUT: |7;RegExp;25075 03:39:36 INFO - 2015-11-24 03:39:36,280 DEBUG : BROWSER_OUTPUT: |8;Splay;712.9760225669958 03:39:36 INFO - 2015-11-24 03:39:36,280 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 03:39:36 INFO - 2015-11-24 03:39:36,280 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:39:36 INFO - 2015-11-24 03:39:36,281 DEBUG : BROWSER_OUTPUT: __startTimestamp1448365176277__endTimestamp 03:39:36 INFO - 2015-11-24 03:39:36,281 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,281 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:39:36 INFO - 2015-11-24 03:39:36,281 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:39:36 INFO - 2015-11-24 03:39:36,282 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,282 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:196.16 Median:196.16 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,282 DEBUG : BROWSER_OUTPUT: Values: 196.2 03:39:36 INFO - 2015-11-24 03:39:36,282 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,282 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.01 Median:192.01 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,283 DEBUG : BROWSER_OUTPUT: Values: 192.0 03:39:36 INFO - 2015-11-24 03:39:36,283 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,284 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,284 DEBUG : BROWSER_OUTPUT: Values: 279.7 03:39:36 INFO - 2015-11-24 03:39:36,284 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,284 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: Values: 5000.0 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: Values: 1067.2 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:698.81 Median:698.81 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: Values: 698.8 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12289.16 Median:12289.16 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,285 DEBUG : BROWSER_OUTPUT: Values: 12289.2 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25075.00 Median:25075.00 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: Values: 25075.0 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:712.98 Median:712.98 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: Values: 713.0 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: Values: 4854.4 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:39:36 INFO - 2015-11-24 03:39:36,286 DEBUG : BROWSER_OUTPUT: 03:39:37 INFO - 2015-11-24 03:39:37,110 INFO : Browser exited with error code: 0 03:39:37 INFO - 2015-11-24 03:39:37,126 INFO : Completed test v8_7 (00:00:39) 03:39:37 INFO - 2015-11-24 03:39:37,303 INFO : Completed test suite (00:20:10) 03:39:37 INFO - 2015-11-24 03:39:37,303 DEBUG : Working with test: dromaeo_css 03:39:37 INFO - 2015-11-24 03:39:37,303 DEBUG : Generating results file: dromaeo_css 03:39:37 INFO - 2015-11-24 03:39:37,304 DEBUG : Working with test: kraken 03:39:37 INFO - 2015-11-24 03:39:37,304 DEBUG : Generating results file: kraken 03:39:37 INFO - 2015-11-24 03:39:37,304 INFO : javascript benchmark 03:39:37 INFO - 2015-11-24 03:39:37,305 DEBUG : Working with test: v8_7 03:39:37 INFO - 2015-11-24 03:39:37,305 DEBUG : Generating results file: v8_7 03:39:37 INFO - 2015-11-24 03:39:37,305 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:37 INFO - 2015-11-24 03:39:37,370 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 03:39:37 INFO - 2015-11-24 03:39:37,370 DEBUG : process_Request line: dromaeo_css 7022.42 graph.html#tests=[[72,64,43]] 03:39:37 INFO - 2015-11-24 03:39:37,371 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:37 INFO - 2015-11-24 03:39:37,414 DEBUG : process_Request line: kraken 1523.30 graph.html#tests=[[232,64,43]] 03:39:37 INFO - 2015-11-24 03:39:37,414 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:37 INFO - 2015-11-24 03:39:37,451 DEBUG : process_Request line: v8_7 20760.78 graph.html#tests=[[230,64,43]] 03:39:37 INFO - 2015-11-24 03:39:37,452 INFO : javascript benchmark 03:39:37 INFO - 2015-11-24 03:39:37,456 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3260.559824423703, 3311.387393332232, 3331.2338162222673, 3354.1782263345476, 3362.344342853143, 5342.946570534294, 5485.588580856437, 5488.067028605132, 5512.614117011811, 5526.032944234758, 5471.37079235888, 5518.172274158878, 5548.029094908385, 5612.943870561293, 5624.943750562493, 4992.151334273173, 5051.848444546669, 5135.435102138762, 5158.7936482540845, 5161.303224064741, 5038.269450929632, 5111.744412779365, 5140.691558506483, 5150.3047088642925, 5169.948300516984, 4953.257011448276, 4967.403911530603, 5097.923531147036, 5104.132297509433, 5118.436971933084, 5135.537801597874, 5136.357955255593, 5136.563392111675, 5152.124138896396, 5168.018076565478, 5108.208227724708, 5126.487351264881, 5126.5898728101665, 5136.1525348317855, 5141.485851414866, 5194.11700010999, 5194.974025129888, 5340.679559226459, 5368.953054154442, 5439.564834813205, 6040.939590604125, 6068.180795592582, 6073.969630151821, 6086.7565297388055, 6101.328853826076, 6065.545084118665, 6094.268687757498, 6102.054181601814, 6117.051856962178, 6117.541184411187, 5488.53347465466, 5571.804986825442, 5581.6371935824045, 5634.408387119375, 5668.0647693130995, 6167.814965551041, 6199.225096862892, 6214.2542894852, 6217.4715149212825, 6226.097215903668, 5702.800401985911, 6016.947034268986, 6023.939760602426, 6024.126501657235, 6047.455728984412, 5923.111533270044, 5990.820275391745, 6022.5483088768515, 6024.246969128859, 6029.758809647565, 5920.437558431942, 5941.287045554561, 5957.1362152487645, 5987.670678112659, 6060.575759696779, 5993.160957465958, 6041.063635136561, 6045.183900173508, 6060.818175454743, 6072.51419886408, 4445.444319460067, 4632.768361581908, 4636.9536304637195, 4638.373819534387, 4649.651276154302, 4043.292423825819, 4055.1078762672164, 4070.578006086374, 4086.1827634473225, 4131.5455299916985, 5637.802676906289, 5714.285714285715, 5715.514181294553, 5727.284089488814, 5797.710114494343, 5876.7649294028615, 5948.821535353946, 6024.457798798129, 6037.969810150921, 6039.7282122304605, 5605.32736071674, 5658.094704847287, 5684.488396044376, 5690.5447564194765, 5742.425757424307, 5212.0, 5239.973800130975, 5243.239730239094, 5262.631615786935, 5287.206918962186, 6021.337652858182, 6077.301110372364, 6116.418940200674, 6214.285357183891, 6246.500279977591, 5979.790707325223, 6030.728617212324, 6068.241469816273, 6069.726862291119, 6111.95640283616, 6144.938550614436, 6172.722227499684, 6204.751809927552, 6216.937830621636, 6222.782202622887, 5768.769249229984, 5844.357120716632, 5906.143609176731, 5909.674967876808, 5924.318703348998, 5872.706364681834, 5930.436608522184, 5938.317093534126, 5939.049752039653, 5981.880362392815, 5911.408859114226, 5946.43508866657, 5956.731947062306, 5969.641821490724, 5997.730102145501, 5886.529077673861, 5923.992921203492, 5943.970280148572, 5946.0, 5956.76172953077, 5590.944090559043, 5713.285839270091, 5758.395368486416, 5844.298684157929, 5895.498882594856, 5926.288845338415, 5946.464818166386, 5979.940200598112, 6017.488513476404, 6018.428249316308, 5773.076307790733, 5800.854978625568, 5814.069748840166, 5820.563457740602, 5827.562932779973], "unit": "ms", "name": "dojo.html", "value": 5535.8088361590935}, {"lowerIsBetter": false, "replicates": [576.2882839692978, 576.7750577274863, 585.373650194292, 587.3216435017554, 590.391896346763, 40303.19393612129, 41423.378649320206, 41432.17135657285, 41480.0, 41810.163796724046, 43948.0, 44384.77807610966, 44681.329780053245, 44883.0, 44909.775451122696, 8766.956165219164, 8883.200511953923, 8910.064443233432, 8934.240589549896, 8936.151065648786, 8717.825643487127, 8839.0, 8853.42452740573, 8855.867161992575, 8861.335399845006, 8820.823583528325, 8839.46963182211, 8890.73327800167, 8908.777280567972, 8917.509536975464, 8818.559072046404, 8821.691240806542, 8856.778580535474, 8868.492356299445, 8892.644294228223, 8649.048604653482, 8768.298536117096, 8796.032436431988, 8800.647974081028, 8806.075362086953, 39494.80252598719, 39696.80151599253, 39814.20371592552, 39905.80047099775, 40066.0, 2859.8570071496342, 3215.839208039612, 3298.1259966109, 3343.114074770188, 3380.408428525023, 29416.411671766444, 29800.701992980008, 30258.0, 30346.965303469697, 31218.53172202419, 3696.057505336149, 3697.4638677391627, 3762.7366084374103, 3765.661090501868, 3799.069228039148, 248329.0, 248509.7574512134, 249116.0, 250000.0, 250369.0, 53143.0, 54003.0, 67711.66144169346, 69349.30650693529, 69359.30640693629, 61680.07479887805, 61826.69086654538, 62251.0, 62253.0, 62306.0, 15772.211389430711, 15874.285657145456, 15904.920475397548, 15928.123953182454, 15964.0, 11966.341851198094, 11986.46060927243, 12000.099992500423, 12112.39438028095, 12114.57708458312, 20232.494187645134, 20282.391528254175, 20544.897275513827, 20618.896905515376, 20668.17327306921, 7522.435817313723, 7684.231576842383, 7717.614119294013, 7776.377889768805, 7807.921920780833, 949.1742184299703, 951.9000504946881, 985.7437066362797, 1027.121810851711, 1044.2481413382352, 26689.3327666806, 27236.863815680794, 27529.44941101207, 27724.30689232785, 27877.303067423072, 1016.6340117557673, 1054.878688950765, 1067.0929709746654, 1093.8906109389156, 1101.388729255255, 14268.500602478864, 14430.474666933245, 14490.0, 14583.002225047663, 14860.777088343684, 291673.0, 295154.0, 296760.0, 297337.0, 298005.0, 52501.47498524966, 52518.47481525212, 52572.21141682878, 52603.73698131561, 52687.473125269025, 1340.6380277325068, 1350.3653282956996, 1350.6420798488605, 1363.3319673360181, 1376.9105008174436, 25379.0, 27146.457070858076, 27565.310867227676, 27609.723902761518, 27805.165845024683, 48819.0, 49386.506134938194, 49490.25764613606, 49561.25658115059, 49766.751166243936, 253102.0, 253857.0, 254811.0, 255523.0, 256085.0, 31177.0, 31675.0, 31783.0, 31944.840275798473, 32089.83955080303, 37832.243355133294, 38424.80787596044, 38603.80698096492, 38689.80655096706, 38718.22563548657, 31411.52882706807, 33004.17489562684, 34216.657833422345, 35198.29603407866, 35736.463953041246, 33707.83146084352, 33789.32421351608, 33911.152221194665, 34106.0, 34163.829180853936, 33588.1602959928, 33619.15952101119, 33911.83044084862, 34093.31813363669, 34225.82887085548, 30691.079267622008, 32897.342053158325, 33326.500102497994, 33406.0, 33641.66358336385, 25235.74764252334, 25984.480310394065, 25995.87002065053, 26083.478330432907, 26166.73833261719], "unit": "ms", "name": "ext.html", "value": 18337.292733435537}, {"lowerIsBetter": false, "replicates": [354.50192479566203, 356.6789889099812, 358.19406335744577, 358.39968053510364, 363.37499500858524, 16455.75316370254, 16738.246778894947, 17266.395676151336, 17390.739138912893, 18027.4591762247, 10744.677659670202, 10747.08649764769, 11129.944350278258, 11139.830317816633, 11139.888601114008, 4817.084753896748, 4841.3464182335465, 4893.608511319104, 4923.9753801230945, 4940.1601727706375, 4863.8784030399165, 4890.608751299906, 4909.484504127069, 4910.06708725341, 4911.140550403683, 4897.706137631753, 4898.951010489903, 5037.722925239111, 5164.922526162091, 5207.791688332462, 5067.366579177566, 5142.588592912558, 5153.922691159635, 5156.664816786915, 5160.948390516084, 5128.102582048164, 5158.200478925735, 5168.508991645787, 5174.404943431516, 5174.844754657366, 12122.272663640122, 12277.877221227764, 12490.81263781044, 12525.749485010248, 12532.624021279376, 1992.481954691776, 2016.616842799878, 2114.947126321839, 2122.0875023739786, 2169.566086782634, 9373.06269373064, 9460.290478214092, 9478.90521094794, 10131.392116472962, 13409.128406653535, 1822.134486119096, 1841.1806745998035, 1847.9260829566936, 1875.9718604220948, 1905.1807722679243, 58474.0, 59697.403025969616, 59928.0, 62215.688921555105, 63310.0, 9936.751581210383, 10228.28402011852, 10231.897681023094, 10292.485375731183, 10349.172066234683, 12890.677733056562, 12948.935255323851, 13576.660583485294, 13614.659633509242, 13628.182309061489, 5814.447627475383, 5836.328822185503, 6582.341765823379, 7381.630918454056, 7391.2978267064545, 7159.212486626467, 7174.892376614355, 7186.353228209487, 7212.3869471094495, 7223.349898509159, 4375.781210939504, 4390.1878152541885, 4446.933296000562, 4461.063176732858, 4465.307877279027, 1818.3181307009872, 1840.0, 1844.97232541512, 1869.560653246486, 1872.700367941123, 855.6149732620346, 881.5548148185126, 930.692871352452, 999.2954966748425, 1041.3335465302212, 15893.284802183929, 16195.757063644054, 16846.14692383837, 17270.740938885927, 17282.04948727807, 888.1695614600369, 936.2884208001832, 981.0336818234034, 999.4403134244847, 1040.7970445763003, 7167.569945803269, 9525.71402860605, 9602.711918642452, 9614.278929080347, 9655.986121457287, 500879.0, 502090.0, 508048.0, 508471.0, 519230.0, 78667.60666196747, 80246.5987670058, 80631.19368806355, 81325.18674813176, 81745.59127204445, 1177.3877583656451, 1179.2099293473393, 1231.2858542045592, 1233.993830030862, 1256.5036810459999, 15156.545303640909, 15340.30968606393, 15357.923210383877, 15364.385424582892, 15552.533423997298, 34605.653943460246, 34635.65364346324, 34984.650153498136, 35375.0, 36302.09244768902, 46583.301250480596, 47022.0, 47424.7628761854, 47776.28335575038, 50812.491875082254, 9425.858612120686, 9492.0, 9583.616655333708, 9612.423254604746, 9659.082387173208, 11696.941515292368, 17183.914080429517, 17503.0, 17805.287788488316, 18190.818091818914, 12937.870621293667, 13624.93187534056, 13657.38541765603, 13889.097208681404, 14266.215358155401, 13731.313434328444, 13750.312484375941, 13939.860601393857, 14471.0, 14486.710265794836, 13360.198388096745, 14036.78944815849, 14227.573172804832, 14535.636609084435, 14548.49080282185, 9329.626814927327, 9708.0, 9858.0, 9870.358426702242, 9924.15644670211, 13868.237246951514, 14462.795488669432, 14694.191819450032, 14803.851961480248, 15020.924895375454], "unit": "ms", "name": "jquery.html", "value": 8563.991162572698}, {"lowerIsBetter": false, "replicates": [1506.6384067823712, 1665.5336505778382, 1727.5249306440735, 1736.8610511159109, 1738.713112336465, 6978.232394436621, 7165.964170179155, 7793.1817159198245, 8013.479123856945, 8041.396895232859, 7637.73267935621, 7752.263534964183, 7815.413843961712, 7844.803879902991, 7859.567723775204, 2235.6870038194666, 2262.3552287598036, 2269.7503274639776, 2274.5337205872756, 2279.076973825603, 2279.384566167142, 2304.8847557622134, 2306.9653955190684, 2307.042577330406, 2315.733690625574, 2230.7657695941934, 2234.486068204314, 2260.1976298414074, 2262.8076613487874, 2275.5448910218024, 2241.3276017194858, 2258.525709600986, 2301.344116926685, 2301.7007788987407, 2303.0212159832004, 2287.1651847075696, 2288.2677543186187, 2312.861228326289, 2313.618252988255, 2315.409570559513, 7727.922720772776, 7769.10655274645, 7798.844023119563, 7830.882536761953, 7850.803729906741, 4705.717656940595, 4744.572988431058, 4791.496892826238, 4795.736234507101, 4796.8560943171415, 3104.5343198520177, 3117.9220519486967, 3183.761217908643, 3205.423023855705, 3220.4203243416177, 988.1107003696659, 1010.4089107871904, 1021.9744506387325, 1027.3835698580867, 1045.2265323660513, 10885.346879187275, 10910.727231819188, 10923.071538919123, 10928.945355273252, 10955.56177752889, 4222.915541689149, 4246.5116511600945, 4279.186954478639, 4293.785310734451, 4294.055307832272, 9353.39202951806, 9379.390339627902, 9381.343305968654, 9405.0, 9406.90593094074, 4697.224957881979, 4724.456687480983, 4727.929081063787, 4742.07529531738, 4759.571638552547, 4301.333293339538, 4310.030243195319, 4314.180305741899, 4382.890427739332, 4386.4736231652405, 3697.408414653696, 3715.0898029982827, 3748.700103991674, 3751.437284407361, 3775.8867233983024, 1221.6090850927797, 1233.4018001269378, 1237.5915947737226, 1238.6346027921604, 1240.3364200152876, 1294.2622705058027, 1296.1445446005591, 1305.3603734170188, 1316.5128902306208, 1332.0, 7122.287771222836, 7138.750143745048, 7141.785746427616, 7231.385332246818, 7386.852262954711, 477.5701868318472, 483.35954859810187, 489.50559934466446, 491.1184423959002, 492.2394899879694, 5727.31272247333, 5727.3699893011735, 5757.712114394263, 5761.48146666802, 5771.192033115367, 8852.557372131369, 9288.071192880792, 9338.719838404722, 9389.154976052188, 9418.434893906251, 9171.63313467454, 9303.534823258946, 9344.112309330603, 9361.157495825408, 9379.155875971195, 7026.92973070273, 7138.892916606255, 7144.392726618192, 7166.319199676022, 7202.423806095605, 7105.25394833535, 7107.928920710933, 7150.284971503016, 7179.0, 7188.065551478484, 7970.681172753025, 8235.052968908652, 8302.252797248277, 8313.251807337369, 8346.374021948499, 8513.489190648581, 8528.957355213184, 8535.231829135408, 8581.442206256574, 8693.34799889998, 5969.462748352669, 6177.073438984188, 6502.967485162544, 6723.394894459522, 6956.513044086865, 7647.9235207649435, 7655.1962043986805, 7684.500507466997, 7703.961480192564, 7705.30652241301, 6955.478339124687, 7017.473689473208, 7068.893966590608, 7225.313595208447, 7295.744648937261, 7001.194862590867, 7082.362587367162, 7111.324424179695, 7196.820079498055, 7235.023271858232, 7057.188423331382, 7083.256258092826, 7177.748778792926, 7191.17301510333, 7193.064901562763, 6607.141071660653, 6620.966895165493, 6657.700403481952, 6708.19501659804, 6712.630805305755, 6477.740890364333, 6500.967495162494, 6522.510811689237, 6680.933190668031, 6749.831254218488], "unit": "ms", "name": "mootools.html", "value": 4436.457625300704}, {"lowerIsBetter": false, "replicates": [316.4541166487807, 318.0966056399824, 324.1313280408505, 328.1337269608233, 331.1456442378662, 6251.843703907404, 6339.7464101436, 6353.777617783373, 6390.424861762441, 6496.837579060514, 6249.406306400896, 6293.213348331458, 6293.244810622732, 6305.779297724581, 6311.431971122598, 4539.046800171951, 4651.418572678415, 4653.88365290867, 4718.74046927418, 4734.9763251183695, 4689.859304220879, 4697.53024697531, 4709.2229782085915, 4713.104510143079, 4725.10223057618, 4643.2802915548145, 4647.837325693601, 4659.53404659533, 4660.277656963176, 4661.86014419568, 4647.14027904837, 4653.162430762462, 4662.090892276007, 4677.532246775329, 4688.624910007191, 3923.2153569286256, 3998.6401223889698, 4006.379011253231, 4012.2376748417705, 4016.2971479990883, 5889.352171261158, 5908.67502287374, 5915.378885217034, 5917.911231331534, 5921.259842519685, 5398.406175320712, 5423.701696406696, 5428.809991650273, 5440.755166017539, 5456.372517160537, 6568.967155164193, 6575.342465753434, 6583.934160658428, 6588.077669126278, 6600.537962342638, 4346.456692913386, 4441.844535441244, 4449.555044495557, 4451.399061126739, 4452.933206001912, 6826.385625293698, 6845.828854278633, 6870.072540207058, 6900.930990690079, 6916.619585922772, 4499.797509112098, 4538.683781703335, 4543.432070991126, 4544.500104988449, 4553.089382123522, 4498.550144985541, 4580.7938642761155, 4589.58693717567, 4595.793189306489, 4596.747178905125, 5433.864153396117, 5434.049041417815, 5436.83689489308, 5439.755211015514, 5443.510084092451, 6685.598864068172, 6702.09521714572, 6707.966460167766, 6718.8320291993095, 6719.462443004548, 1627.1701432269629, 1645.6708658268155, 1648.2253340929744, 1650.191406210948, 1650.3233674193764, 1062.166199533378, 1076.036946932491, 1077.28898926708, 1082.8213344798178, 1082.8917108289265, 6379.425851673372, 6436.678166091677, 6457.418832305115, 6466.0, 6469.029645553204, 6974.093367862146, 6992.1958974717545, 6994.440444764508, 6998.580085194904, 7005.649717514104, 6524.641144737085, 6542.967285163544, 6552.180977377828, 6552.3447655234095, 6556.803295901131, 3700.888973330804, 3774.0753515388906, 3783.319002579507, 3796.1648437343742, 3805.771653700787, 7243.0, 7260.165081015751, 7266.237045110293, 7267.63661816907, 7270.600116993511, 7133.536320139175, 7165.96417017922, 7170.354668079898, 7174.928250717426, 7186.850103983337, 7090.397316228178, 7222.0, 7250.129984401906, 7264.164621068433, 7270.527415717961, 6904.067950826574, 6910.894256918868, 6914.343137401939, 6967.372936435745, 6976.930230697831, 6851.588904665736, 6886.896696549456, 6890.827729306808, 6901.89647155283, 6907.896381554381, 7025.929740702528, 7256.818579535554, 7257.854842903007, 7262.782116536512, 7269.890951635624, 4601.217792975269, 4619.284010978304, 4638.53614638547, 4649.093426781745, 4651.604613607881, 6862.656867156722, 6887.896681549681, 6937.167539895245, 6949.235584085645, 6971.755988540377, 6644.169478815148, 6726.461883049442, 6732.394084532416, 6755.763548275787, 6766.086578311865, 6757.358050985148, 6759.763408280686, 6765.594064356154, 6773.729050838108, 6785.5911151540495, 6479.676016199077, 6608.0, 6627.271000190071, 6629.43649789754, 6653.800385988428, 6518.641474718746, 6693.364130407604, 6767.89848152288, 6787.0, 6787.5588086774205, 6403.551751377358, 6596.571222870498, 6627.304133066152, 6634.800955971328, 6644.136262285871], "unit": "ms", "name": "prototype.html", "value": 4984.6595395806935}, {"lowerIsBetter": false, "replicates": [681.7886455198889, 734.9485536012479, 748.9925100748994, 776.6776787633129, 826.3224156191925, 13227.272500012496, 13468.0, 13488.393022313994, 13527.25600091997, 13561.32193390329, 12358.38208089594, 12416.689582760413, 12424.130310878241, 12435.875641243585, 12443.253404795718, 817.6770175780563, 832.4381042796118, 834.3658819297317, 835.0605568735173, 836.7406104107715, 829.1956801902145, 840.2941529115542, 840.7099550655045, 841.7180244618061, 847.8007668197969, 860.9182127697859, 866.2680035370103, 869.2481003931617, 870.3211495033884, 872.0451106038877, 858.9226969572737, 865.208334374047, 865.7446053414258, 867.2411639815161, 868.9913100868973, 634.7619642634012, 636.8439732265624, 636.9172007639023, 637.6556659403916, 638.084348959245, 13887.375068121959, 13971.930140349335, 13982.720345593132, 14057.789133162909, 14092.577222683336, 10722.678319650346, 10845.0, 11950.0, 12109.636710898687, 12305.323207223599, 10302.227332949984, 10346.793064138676, 10348.58605655773, 10389.168866490738, 10402.271840971134, 3456.084137703511, 3474.5656792900886, 3488.89533314001, 3526.0832183632183, 3544.9645503544893, 48737.0, 49352.75323623395, 49375.0, 49454.50545494535, 49474.0, 9230.86153707695, 9574.0, 10132.645357412455, 10235.539400726986, 10252.948735256276, 16754.58113547171, 16768.161591920354, 16791.748123778154, 16848.663026739396, 16864.325426982785, 6729.764458243938, 7496.062992125984, 7670.057104735176, 7747.961260193776, 7806.219378062148, 4417.558244175621, 4439.778011099432, 4472.932906006413, 4482.887927801766, 4514.322851572225, 3058.2201538607956, 3060.32672811981, 3065.3409516953516, 3066.8313242771414, 3067.8772849085785, 546.1398297681168, 559.8348487196287, 570.4010788671878, 573.7905664432452, 575.0368133376578, 622.5113286070413, 633.3539789414863, 635.6154526511394, 668.6690088406173, 721.3219573600799, 8926.598303076376, 8935.106489351012, 8996.370254082152, 9026.909730902738, 9202.81594368109, 551.3561582925729, 611.3580740222749, 662.7779693802534, 690.4993879437368, 701.4703898556558, 4092.856750013735, 4148.253314403436, 4211.347241177622, 4275.337322714984, 4386.890327741832, 56519.43480565141, 57568.13647795287, 57688.71155644195, 58286.708566456895, 58371.0, 52072.73963630158, 52218.95044169064, 52906.0, 53375.199372009454, 53453.465465344845, 45977.540224597324, 46245.53754462547, 46675.76662116668, 46889.29666055012, 46900.5309946903, 8436.11420800807, 8527.763474296069, 8560.614772335384, 8582.570871456526, 8621.180987806149, 34506.482402763475, 35024.12439688926, 35450.82274588611, 35489.11277217987, 35643.82178089093, 41756.58243417527, 44126.11747765091, 45216.32175517304, 45233.32150017686, 45685.31472027989, 10260.794784104426, 10337.638182663572, 10448.634297799541, 10544.15646748243, 10802.945985270024, 11091.279066860629, 11207.383593902088, 11393.373364465035, 11395.658130256106, 11693.590724324607, 9924.206063515046, 9975.251856110675, 10245.590176392861, 10272.435016073889, 10772.407517586607, 10198.694039178836, 10206.846897296695, 10386.584536618451, 10704.625338113128, 10857.457127143452, 10427.374357538269, 10501.89498105009, 10512.632057877938, 10568.154547636017, 10633.096186824207, 9103.772405689911, 9130.178283954476, 9137.131972462605, 9359.39163954368, 9545.522723863918, 9056.864147037668, 9294.674686385944, 9377.859332109887, 9446.905530944603, 9448.48033358172], "unit": "ms", "name": "yui.html", "value": 6237.621841722898}], "name": "dromaeo_css", "value": 7022.417326519782}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 113.0, 111.0, 112.0, 122.0, 110.0, 114.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 166.0, 167.0, 128.0, 151.0, 156.0, 136.0, 165.0, 136.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 161.0, 164.0, 160.0, 164.0, 162.0, 171.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 72.0, 72.0, 71.0, 72.0, 73.0, 135.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 95.0, 94.0, 93.0, 136.0, 92.0, 94.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 146.0, 148.0, 149.0, 147.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 61.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 70.0, 70.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [92.0, 88.0, 86.0, 94.0, 85.0, 87.0, 85.0, 95.0, 89.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.7}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 115.0, 121.0, 127.0, 120.0, 121.0, 118.0, 122.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 151.0, 152.0, 153.0, 151.0, 157.0, 148.0, 150.0, 155.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 69.0, 75.0, 70.0, 68.0, 67.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1523.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [196.15535504119262], "unit": "score", "name": "Richards", "value": 179.96959600000002}, {"lowerIsBetter": false, "replicates": [192.01228878648234], "unit": "score", "name": "DeltaBlue", "value": 344.3425439999999}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [698.8120195667366], "unit": "score", "name": "Earley", "value": 953.7085530000003}, {"lowerIsBetter": false, "replicates": [12289.156626506025], "unit": "score", "name": "Boyer", "value": 54.23179313725487}, {"lowerIsBetter": false, "replicates": [25075.0], "unit": "score", "name": "RegExp", "value": 36.33040877367896}, {"lowerIsBetter": false, "replicates": [712.9760225669958], "unit": "score", "name": "Splay", "value": 114.29697131552919}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20760.777917139858}]} 03:39:37 INFO - RETURN: dromaeo_css: 7022.42 03:39:37 INFO - RETURN: kraken: 1523.30 03:39:37 INFO - RETURN: v8_7: 20760.78 03:39:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20760.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1523.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7022.42"}}} 03:39:37 INFO - Return code: 0 03:39:37 INFO - # TBPL SUCCESS # 03:39:37 INFO - Running post-action listener: _resource_record_post_action 03:39:37 INFO - Running post-run listener: _resource_record_post_run 03:39:38 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 28672; Write bytes: 525746176; Read time: 268; Write time: 519956 03:39:38 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 168693760; Read time: 124; Write time: 194776 03:39:38 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 24576; Write bytes: 275107840; Read time: 144; Write time: 134496 03:39:38 INFO - Running post-run listener: _upload_blobber_files 03:39:38 INFO - Blob upload gear active. 03:39:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:39:38 INFO - Copying logs to upload dir... 03:39:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.587013 ========= master_lag: 84.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2015-11-24 03:41:03.305420) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.311915) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010076 build_url: 'https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.41 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.733155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.733523) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1448361038.278159-1771022838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.764888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 03:41:03.765210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 03:41:03.778894) ========= ========= Total master_lag: 85.38 =========