builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1447888685.39 results: success (0) buildid: 20151118143035 builduid: 9613a881f6bc49c6befcca21362ca574 revision: 24c5d435977da94d3986c89085496d8ddef6f1b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.393233) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.393751) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.394070) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007673 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.424177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.424514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.482743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.483328) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.537653) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.538156) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.538537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.538958) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 15:18:05-- 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% 43.9M=0s 2015-11-18 15:18:05 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.658322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.658601) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022090 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.711246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:05.711606) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 24c5d435977da94d3986c89085496d8ddef6f1b2 --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 24c5d435977da94d3986c89085496d8ddef6f1b2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 15:18:06,107 truncating revision to first 12 chars 2015-11-18 15:18:06,108 Setting DEBUG logging. 2015-11-18 15:18:06,108 attempt 1/10 2015-11-18 15:18:06,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/24c5d435977d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 15:18:06,354 unpacking tar archive at: fx-team-24c5d435977d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:06.242017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:06.242438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:06.252711) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:06.253033) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 15:18:06.253464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-18 15:18:06.253832) ========= /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=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:18:06 INFO - MultiFileLogger online at 20151118 15:18:06 in /builds/slave/test-pgo 15:18:06 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 15:18:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:18:06 INFO - {'append_to_log': False, 15:18:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:18:06 INFO - 'blob_upload_branch': 'Fx-Team', 15:18:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:18:06 INFO - 'branch': 'Fx-Team', 15:18:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:06 INFO - 'config_files': ('talos/linux_config.py',), 15:18:06 INFO - 'default_actions': ('clobber', 15:18:06 INFO - 'read-buildbot-config', 15:18:06 INFO - 'download-and-extract', 15:18:06 INFO - 'populate-webroot', 15:18:06 INFO - 'create-virtualenv', 15:18:06 INFO - 'install', 15:18:06 INFO - 'run-tests'), 15:18:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:06 INFO - 'download_minidump_stackwalk': True, 15:18:06 INFO - 'download_symbols': 'ondemand', 15:18:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:06 INFO - 'installer_path': 'installer.exe', 15:18:06 INFO - 'log_level': 'info', 15:18:06 INFO - 'log_name': 'talos', 15:18:06 INFO - 'log_to_console': True, 15:18:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:18:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:18:06 INFO - 'opt_config_files': (), 15:18:06 INFO - 'pip_index': False, 15:18:06 INFO - 'sps_profile': False, 15:18:06 INFO - 'sps_profile_interval': 0, 15:18:06 INFO - 'suite': 'dromaeojs-e10s', 15:18:06 INFO - 'system_bits': '64', 15:18:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:06 INFO - 'title': 'talos-linux64-ix-047', 15:18:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:06 INFO - 'use_talos_json': True, 15:18:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:18:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:06 INFO - 'work_dir': 'build'} 15:18:06 INFO - ##### 15:18:06 INFO - ##### Running clobber step. 15:18:06 INFO - ##### 15:18:06 INFO - Running pre-action listener: _resource_record_pre_action 15:18:06 INFO - Running main action method: clobber 15:18:06 INFO - rmtree: /builds/slave/test-pgo/build 15:18:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:18:07 INFO - Running post-action listener: _resource_record_post_action 15:18:07 INFO - ##### 15:18:07 INFO - ##### Running read-buildbot-config step. 15:18:07 INFO - ##### 15:18:07 INFO - Running pre-action listener: _resource_record_pre_action 15:18:07 INFO - Running main action method: read_buildbot_config 15:18:07 INFO - Using buildbot properties: 15:18:07 INFO - { 15:18:07 INFO - "properties": { 15:18:07 INFO - "buildnumber": 95, 15:18:07 INFO - "product": "firefox", 15:18:07 INFO - "script_repo_revision": "production", 15:18:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:18:07 INFO - "repository": "", 15:18:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:18:07 INFO - "buildid": "20151118143035", 15:18:07 INFO - "slavename": "talos-linux64-ix-047", 15:18:07 INFO - "pgo_build": "True", 15:18:07 INFO - "basedir": "/builds/slave/test-pgo", 15:18:07 INFO - "project": "", 15:18:07 INFO - "platform": "ubuntu64_hw", 15:18:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:18:07 INFO - "slavebuilddir": "test", 15:18:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:18:07 INFO - "branch": "fx-team", 15:18:07 INFO - "repo_path": "integration/fx-team", 15:18:07 INFO - "stage_platform": "linux64-pgo", 15:18:07 INFO - "builduid": "9613a881f6bc49c6befcca21362ca574", 15:18:07 INFO - "revision": "24c5d435977da94d3986c89085496d8ddef6f1b2" 15:18:07 INFO - }, 15:18:07 INFO - "sourcestamp": { 15:18:07 INFO - "repository": "", 15:18:07 INFO - "hasPatch": false, 15:18:07 INFO - "project": "", 15:18:07 INFO - "branch": "fx-team-linux64-pgo-talos", 15:18:07 INFO - "changes": [ 15:18:07 INFO - { 15:18:07 INFO - "category": null, 15:18:07 INFO - "files": [ 15:18:07 INFO - { 15:18:07 INFO - "url": null, 15:18:07 INFO - "name": "https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:18:07 INFO - } 15:18:07 INFO - ], 15:18:07 INFO - "repository": "", 15:18:07 INFO - "rev": "24c5d435977da94d3986c89085496d8ddef6f1b2", 15:18:07 INFO - "who": "sendchange", 15:18:07 INFO - "when": 1447888627, 15:18:07 INFO - "number": 6679296, 15:18:07 INFO - "comments": "", 15:18:07 INFO - "project": "", 15:18:07 INFO - "at": "Wed 18 Nov 2015 15:17:07", 15:18:07 INFO - "branch": "fx-team-linux64-pgo-talos", 15:18:07 INFO - "revlink": "", 15:18:07 INFO - "properties": [ 15:18:07 INFO - [ 15:18:07 INFO - "buildid", 15:18:07 INFO - "20151118143035", 15:18:07 INFO - "Change" 15:18:07 INFO - ], 15:18:07 INFO - [ 15:18:07 INFO - "builduid", 15:18:07 INFO - "9613a881f6bc49c6befcca21362ca574", 15:18:07 INFO - "Change" 15:18:07 INFO - ], 15:18:07 INFO - [ 15:18:07 INFO - "pgo_build", 15:18:07 INFO - "True", 15:18:07 INFO - "Change" 15:18:07 INFO - ] 15:18:07 INFO - ], 15:18:07 INFO - "revision": "24c5d435977da94d3986c89085496d8ddef6f1b2" 15:18:07 INFO - } 15:18:07 INFO - ], 15:18:07 INFO - "revision": "24c5d435977da94d3986c89085496d8ddef6f1b2" 15:18:07 INFO - } 15:18:07 INFO - } 15:18:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:18:07 INFO - Running post-action listener: _resource_record_post_action 15:18:07 INFO - ##### 15:18:07 INFO - ##### Running download-and-extract step. 15:18:07 INFO - ##### 15:18:07 INFO - Running pre-action listener: _resource_record_pre_action 15:18:07 INFO - Running main action method: download_and_extract 15:18:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:07 INFO - https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/test_packages.json 15:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/test_packages.json 15:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:18:12 INFO - Downloaded 1302 bytes. 15:18:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:18:12 INFO - Using the following test package requirements: 15:18:12 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:18:12 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:12 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'jsshell-linux-x86_64.zip'], 15:18:12 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:12 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:18:12 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:18:12 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:18:12 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:12 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:18:12 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:18:12 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:12 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:12 INFO - https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:15 INFO - Downloaded 22475405 bytes. 15:18:15 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 15:18:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:18:15 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 15:18:16 INFO - Return code: 0 15:18:16 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 15:18:16 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')]} 15:18:16 INFO - https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:18 INFO - Downloaded 22475405 bytes. 15:18:18 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 15:18:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:18:18 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 15:18:19 INFO - Return code: 0 15:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:19 INFO - https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:21 INFO - Downloaded 11130997 bytes. 15:18:21 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 15:18:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:18:21 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 15:18:21 INFO - Return code: 0 15:18:21 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')]} 15:18:21 INFO - https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9lZYR0OmTyyxtdBqQi7I-w/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 15:18:23 INFO - Downloaded 57210016 bytes. 15:18:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:18:23 INFO - mkdir: /builds/slave/test-pgo/properties 15:18:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:18:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:18:23 INFO - Contents: 15:18:23 INFO - build_url:https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:18:23 INFO - Running post-action listener: _resource_record_post_action 15:18:23 INFO - Running post-action listener: set_extra_try_arguments 15:18:23 INFO - ##### 15:18:23 INFO - ##### Running populate-webroot step. 15:18:23 INFO - ##### 15:18:23 INFO - Running pre-action listener: _resource_record_pre_action 15:18:23 INFO - Running main action method: populate_webroot 15:18:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:23 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:18:23 INFO - '../fennec_ids.txt'], 15:18:23 INFO - 'tests': ['tcheck2']}, 15:18:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:23 INFO - '--tppagecycles', 15:18:23 INFO - '7'], 15:18:23 INFO - 'tests': ['tsvgm']}}, 15:18:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:18:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:18:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:18:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'tests': ['damp', 'tps']}, 15:18:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['damp', 'tps']}, 15:18:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:18:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:23 INFO - 'other': {'tests': ['a11yr', 15:18:23 INFO - 'ts_paint', 15:18:23 INFO - 'tpaint', 15:18:23 INFO - 'sessionrestore', 15:18:23 INFO - 'sessionrestore_no_auto_restore']}, 15:18:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['a11yr', 15:18:23 INFO - 'ts_paint', 15:18:23 INFO - 'tpaint', 15:18:23 INFO - 'sessionrestore', 15:18:23 INFO - 'sessionrestore_no_auto_restore']}, 15:18:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['a11yr', 15:18:23 INFO - 'ts_paint', 15:18:23 INFO - 'tpaint', 15:18:23 INFO - 'sessionrestore', 15:18:23 INFO - 'sessionrestore_no_auto_restore']}, 15:18:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['a11yr', 15:18:23 INFO - 'ts_paint', 15:18:23 INFO - 'tpaint', 15:18:23 INFO - 'sessionrestore', 15:18:23 INFO - 'sessionrestore_no_auto_restore']}, 15:18:23 INFO - 'other_l64': {'tests': ['a11yr', 15:18:23 INFO - 'ts_paint', 15:18:23 INFO - 'tpaint', 15:18:23 INFO - 'sessionrestore', 15:18:23 INFO - 'sessionrestore_no_auto_restore']}, 15:18:23 INFO - 'other_nol64': {'tests': ['a11yr', 15:18:23 INFO - 'ts_paint', 15:18:23 INFO - 'tpaint', 15:18:23 INFO - 'sessionrestore', 15:18:23 INFO - 'sessionrestore_no_auto_restore']}, 15:18:23 INFO - 'svgr': {'tests': ['tsvgx', 15:18:23 INFO - 'tsvgr_opacity', 15:18:23 INFO - 'tart', 15:18:23 INFO - 'tscrollx', 15:18:23 INFO - 'cart']}, 15:18:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['tsvgx', 15:18:23 INFO - 'tsvgr_opacity', 15:18:23 INFO - 'tart', 15:18:23 INFO - 'tscrollx', 15:18:23 INFO - 'cart']}, 15:18:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'tests': ['tp5o']}, 15:18:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'talos_options': ['--e10s'], 15:18:23 INFO - 'tests': ['tp5o']}, 15:18:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'talos_options': ['--xperf_path', 15:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:23 INFO - 'tests': ['tp5n']}, 15:18:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:23 INFO - 'talos_options': ['--e10s', 15:18:23 INFO - '--xperf_path', 15:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:23 INFO - 'tests': ['tp5n']}}, 15:18:23 INFO - 'talos.zip': {'path': '', 15:18:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:18:23 INFO - Running post-action listener: _resource_record_post_action 15:18:23 INFO - ##### 15:18:23 INFO - ##### Running create-virtualenv step. 15:18:23 INFO - ##### 15:18:23 INFO - Running pre-action listener: _resource_record_pre_action 15:18:23 INFO - Running main action method: create_virtualenv 15:18:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:18:23 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 15:18:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:18:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:23 INFO - Using real prefix '/usr' 15:18:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:18:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:25 INFO - Installing pip.................done. 15:18:25 INFO - Return code: 0 15:18:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:25 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 15:18:25 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 15:18:25 INFO - Using env: {'DISPLAY': ':0', 15:18:25 INFO - 'HOME': '/home/cltbld', 15:18:25 INFO - 'LANG': 'en_US.UTF-8', 15:18:25 INFO - 'LANGUAGE': 'en_US:en', 15:18:25 INFO - 'LOGNAME': 'cltbld', 15:18:25 INFO - 'MAIL': '/var/mail/cltbld', 15:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:25 INFO - 'MOZ_NO_REMOTE': '1', 15:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:25 INFO - 'NO_EM_RESTART': '1', 15:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:25 INFO - 'SHELL': '/bin/bash', 15:18:25 INFO - 'SHLVL': '1', 15:18:25 INFO - 'TERM': 'linux', 15:18:25 INFO - 'TMOUT': '86400', 15:18:25 INFO - 'USER': 'cltbld', 15:18:25 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:25 INFO - '_': '/tools/buildbot/bin/python'} 15:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:25 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 15:18:25 INFO - Cleaning up... 15:18:25 INFO - Return code: 0 15:18:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:25 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 15:18:25 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 15:18:25 INFO - Using env: {'DISPLAY': ':0', 15:18:25 INFO - 'HOME': '/home/cltbld', 15:18:25 INFO - 'LANG': 'en_US.UTF-8', 15:18:25 INFO - 'LANGUAGE': 'en_US:en', 15:18:25 INFO - 'LOGNAME': 'cltbld', 15:18:25 INFO - 'MAIL': '/var/mail/cltbld', 15:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:25 INFO - 'MOZ_NO_REMOTE': '1', 15:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:25 INFO - 'NO_EM_RESTART': '1', 15:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:25 INFO - 'SHELL': '/bin/bash', 15:18:25 INFO - 'SHLVL': '1', 15:18:25 INFO - 'TERM': 'linux', 15:18:25 INFO - 'TMOUT': '86400', 15:18:25 INFO - 'USER': 'cltbld', 15:18:25 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:25 INFO - '_': '/tools/buildbot/bin/python'} 15:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:26 INFO - Downloading/unpacking psutil>=0.7.1 15:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:27 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:18:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:18:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:27 INFO - Installing collected packages: psutil 15:18:27 INFO - Running setup.py install for psutil 15:18:28 INFO - building 'psutil._psutil_linux' extension 15:18:28 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 15:18:28 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 15:18:28 INFO - building 'psutil._psutil_posix' extension 15:18:28 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 15:18:28 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 15:18:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:28 INFO - Successfully installed psutil 15:18:28 INFO - Cleaning up... 15:18:28 INFO - Return code: 0 15:18:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:18:28 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')]} 15:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:28 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')]} 15:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:28 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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:28 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 15:18:28 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 15:18:28 INFO - Using env: {'DISPLAY': ':0', 15:18:28 INFO - 'HOME': '/home/cltbld', 15:18:28 INFO - 'LANG': 'en_US.UTF-8', 15:18:28 INFO - 'LANGUAGE': 'en_US:en', 15:18:28 INFO - 'LOGNAME': 'cltbld', 15:18:28 INFO - 'MAIL': '/var/mail/cltbld', 15:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:28 INFO - 'MOZ_NO_REMOTE': '1', 15:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:28 INFO - 'NO_EM_RESTART': '1', 15:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:28 INFO - 'SHELL': '/bin/bash', 15:18:28 INFO - 'SHLVL': '1', 15:18:28 INFO - 'TERM': 'linux', 15:18:28 INFO - 'TMOUT': '86400', 15:18:28 INFO - 'USER': 'cltbld', 15:18:28 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:28 INFO - '_': '/tools/buildbot/bin/python'} 15:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:18:28 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 15:18:28 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 15:18:28 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 15:18:28 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 15:18:28 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 15:18:28 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 15:18:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:18:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:18:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:18:30 INFO - Installing collected packages: mozsystemmonitor 15:18:30 INFO - Running setup.py install for mozsystemmonitor 15:18:30 INFO - Successfully installed mozsystemmonitor 15:18:30 INFO - Cleaning up... 15:18:30 INFO - Return code: 0 15:18:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:30 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 15:18:30 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 15:18:30 INFO - Using env: {'DISPLAY': ':0', 15:18:30 INFO - 'HOME': '/home/cltbld', 15:18:30 INFO - 'LANG': 'en_US.UTF-8', 15:18:30 INFO - 'LANGUAGE': 'en_US:en', 15:18:30 INFO - 'LOGNAME': 'cltbld', 15:18:30 INFO - 'MAIL': '/var/mail/cltbld', 15:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:30 INFO - 'MOZ_NO_REMOTE': '1', 15:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:30 INFO - 'NO_EM_RESTART': '1', 15:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:30 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:30 INFO - 'SHELL': '/bin/bash', 15:18:30 INFO - 'SHLVL': '1', 15:18:30 INFO - 'TERM': 'linux', 15:18:30 INFO - 'TMOUT': '86400', 15:18:30 INFO - 'USER': 'cltbld', 15:18:30 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:30 INFO - '_': '/tools/buildbot/bin/python'} 15:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:30 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:30 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 15:18:30 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 15:18:30 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 15:18:30 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 15:18:30 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 15:18:30 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 15:18:32 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:18:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:18:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:18:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:33 INFO - Downloading docopt-0.6.1.tar.gz 15:18:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:18:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:33 INFO - Running setup.py install for blobuploader 15:18:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:18:33 INFO - Running setup.py install for requests 15:18:33 INFO - Running setup.py install for docopt 15:18:33 INFO - Successfully installed blobuploader requests docopt 15:18:33 INFO - Cleaning up... 15:18:33 INFO - Return code: 0 15:18:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:18:33 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')]} 15:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:33 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')]} 15:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:33 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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:33 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 15:18:33 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 15:18:33 INFO - Using env: {'DISPLAY': ':0', 15:18:33 INFO - 'HOME': '/home/cltbld', 15:18:33 INFO - 'LANG': 'en_US.UTF-8', 15:18:33 INFO - 'LANGUAGE': 'en_US:en', 15:18:33 INFO - 'LOGNAME': 'cltbld', 15:18:33 INFO - 'MAIL': '/var/mail/cltbld', 15:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:33 INFO - 'MOZ_NO_REMOTE': '1', 15:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:33 INFO - 'NO_EM_RESTART': '1', 15:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:33 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:33 INFO - 'SHELL': '/bin/bash', 15:18:33 INFO - 'SHLVL': '1', 15:18:33 INFO - 'TERM': 'linux', 15:18:33 INFO - 'TMOUT': '86400', 15:18:33 INFO - 'USER': 'cltbld', 15:18:33 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:33 INFO - '_': '/tools/buildbot/bin/python'} 15:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:33 INFO - Running setup.py (path:/tmp/pip-orTXby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:33 INFO - Running setup.py (path:/tmp/pip-AmSYEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:34 INFO - Running setup.py (path:/tmp/pip-QHPspa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:34 INFO - Running setup.py (path:/tmp/pip-OMeAO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:34 INFO - Running setup.py (path:/tmp/pip-KSag6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:34 INFO - Running setup.py (path:/tmp/pip-UkhvKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:34 INFO - Running setup.py (path:/tmp/pip-cuUXn2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:34 INFO - Running setup.py (path:/tmp/pip-UHLhoH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:34 INFO - Running setup.py (path:/tmp/pip-EErnq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:34 INFO - Running setup.py (path:/tmp/pip-GFljQs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:34 INFO - Running setup.py (path:/tmp/pip-HbszkB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:34 INFO - Running setup.py (path:/tmp/pip-rVcL09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:34 INFO - Running setup.py (path:/tmp/pip-9XWgxJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:34 INFO - Running setup.py (path:/tmp/pip-rjhbu3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:34 INFO - Running setup.py (path:/tmp/pip-ZumR3A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:34 INFO - Running setup.py (path:/tmp/pip-g9mi2j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:35 INFO - Running setup.py (path:/tmp/pip-skgvgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:35 INFO - Running setup.py install for manifestparser 15:18:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Running setup.py install for mozcrash 15:18:35 INFO - Running setup.py install for mozdebug 15:18:35 INFO - Running setup.py install for mozdevice 15:18:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Running setup.py install for mozfile 15:18:35 INFO - Running setup.py install for mozhttpd 15:18:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Running setup.py install for mozinfo 15:18:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Running setup.py install for mozInstall 15:18:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:18:35 INFO - Running setup.py install for mozleak 15:18:36 INFO - Running setup.py install for mozlog 15:18:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Running setup.py install for moznetwork 15:18:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Running setup.py install for mozprocess 15:18:36 INFO - Running setup.py install for mozprofile 15:18:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Running setup.py install for mozrunner 15:18:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Running setup.py install for mozscreenshot 15:18:36 INFO - Running setup.py install for moztest 15:18:36 INFO - Running setup.py install for mozversion 15:18:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:18:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:36 INFO - Cleaning up... 15:18:36 INFO - Return code: 0 15:18:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:18:36 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')]} 15:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:36 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')]} 15:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:36 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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:36 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 15:18:36 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 15:18:36 INFO - Using env: {'DISPLAY': ':0', 15:18:36 INFO - 'HOME': '/home/cltbld', 15:18:36 INFO - 'LANG': 'en_US.UTF-8', 15:18:36 INFO - 'LANGUAGE': 'en_US:en', 15:18:36 INFO - 'LOGNAME': 'cltbld', 15:18:36 INFO - 'MAIL': '/var/mail/cltbld', 15:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:36 INFO - 'MOZ_NO_REMOTE': '1', 15:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:36 INFO - 'NO_EM_RESTART': '1', 15:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:36 INFO - 'SHELL': '/bin/bash', 15:18:36 INFO - 'SHLVL': '1', 15:18:36 INFO - 'TERM': 'linux', 15:18:36 INFO - 'TMOUT': '86400', 15:18:36 INFO - 'USER': 'cltbld', 15:18:36 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:36 INFO - '_': '/tools/buildbot/bin/python'} 15:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:37 INFO - Running setup.py (path:/tmp/pip-R7uxwx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:37 INFO - Running setup.py (path:/tmp/pip-P3tu44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:37 INFO - Running setup.py (path:/tmp/pip-CZP6_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:37 INFO - Running setup.py (path:/tmp/pip-WGYID0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:37 INFO - Running setup.py (path:/tmp/pip-EHILMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:37 INFO - Running setup.py (path:/tmp/pip-jTp63v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:37 INFO - Running setup.py (path:/tmp/pip-CvOgf1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:37 INFO - Running setup.py (path:/tmp/pip-LPTImP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:37 INFO - Running setup.py (path:/tmp/pip-sPboGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:37 INFO - Running setup.py (path:/tmp/pip-Z89Keh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:37 INFO - Running setup.py (path:/tmp/pip-C3yo0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:37 INFO - Running setup.py (path:/tmp/pip-4HzNgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:18:37 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)) 15:18:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:38 INFO - Running setup.py (path:/tmp/pip-uzXfG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:18:38 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)) 15:18:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:38 INFO - Running setup.py (path:/tmp/pip-BzjmP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:18:38 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)) 15:18:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:38 INFO - Running setup.py (path:/tmp/pip-zfa7jh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:18:38 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)) 15:18:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:38 INFO - Running setup.py (path:/tmp/pip-78qq7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:18:38 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)) 15:18:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:38 INFO - Running setup.py (path:/tmp/pip-93Y5Jw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:18:38 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)) 15:18:38 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)) 15:18:38 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)) 15:18:38 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)) 15:18:38 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)) 15:18:38 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)) 15:18:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:39 INFO - Downloading blessings-1.5.1.tar.gz 15:18:39 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 15:18:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:40 INFO - Installing collected packages: blessings 15:18:40 INFO - Running setup.py install for blessings 15:18:40 INFO - Successfully installed blessings 15:18:40 INFO - Cleaning up... 15:18:40 INFO - Return code: 0 15:18:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:18:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:18:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:18:40 INFO - Reading from file tmpfile_stdout 15:18:40 INFO - Current package versions: 15:18:40 INFO - argparse == 1.2.1 15:18:40 INFO - blessings == 1.5.1 15:18:40 INFO - blobuploader == 1.2.4 15:18:40 INFO - docopt == 0.6.1 15:18:40 INFO - manifestparser == 1.1 15:18:40 INFO - mozInstall == 1.12 15:18:40 INFO - mozcrash == 0.16 15:18:40 INFO - mozdebug == 0.1 15:18:40 INFO - mozdevice == 0.47 15:18:40 INFO - mozfile == 1.2 15:18:40 INFO - mozhttpd == 0.7 15:18:40 INFO - mozinfo == 0.9 15:18:40 INFO - mozleak == 0.1 15:18:40 INFO - mozlog == 3.0 15:18:40 INFO - moznetwork == 0.27 15:18:40 INFO - mozprocess == 0.22 15:18:40 INFO - mozprofile == 0.27 15:18:40 INFO - mozrunner == 6.11 15:18:40 INFO - mozscreenshot == 0.1 15:18:40 INFO - mozsystemmonitor == 0.0 15:18:40 INFO - moztest == 0.7 15:18:40 INFO - mozversion == 1.4 15:18:40 INFO - psutil == 3.1.1 15:18:40 INFO - requests == 1.2.3 15:18:40 INFO - wsgiref == 0.1.2 15:18:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:40 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 0x7ff51c9f5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', '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 15:18:40 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 15:18:40 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 15:18:40 INFO - Using env: {'DISPLAY': ':0', 15:18:40 INFO - 'HOME': '/home/cltbld', 15:18:40 INFO - 'LANG': 'en_US.UTF-8', 15:18:40 INFO - 'LANGUAGE': 'en_US:en', 15:18:40 INFO - 'LOGNAME': 'cltbld', 15:18:40 INFO - 'MAIL': '/var/mail/cltbld', 15:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:40 INFO - 'MOZ_NO_REMOTE': '1', 15:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:40 INFO - 'NO_EM_RESTART': '1', 15:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:40 INFO - 'SHELL': '/bin/bash', 15:18:40 INFO - 'SHLVL': '1', 15:18:40 INFO - 'TERM': 'linux', 15:18:40 INFO - 'TMOUT': '86400', 15:18:40 INFO - 'USER': 'cltbld', 15:18:40 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:40 INFO - '_': '/tools/buildbot/bin/python'} 15:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 INFO - Cleaning up... 15:18:40 INFO - Return code: 0 15:18:40 INFO - Running post-action listener: _resource_record_post_action 15:18:40 INFO - Running post-action listener: _start_resource_monitoring 15:18:40 INFO - Starting resource monitoring. 15:18:40 INFO - ##### 15:18:40 INFO - ##### Running install step. 15:18:40 INFO - ##### 15:18:40 INFO - Running pre-action listener: _resource_record_pre_action 15:18:40 INFO - Running main action method: install 15:18:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:18:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:18:40 INFO - Reading from file tmpfile_stdout 15:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:18:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:18:40 INFO - Reading from file tmpfile_stdout 15:18:40 INFO - Output received: 15:18:40 INFO - Usage: mozinstall [options] installer 15:18:40 INFO - Options: 15:18:40 INFO - -h, --help show this help message and exit 15:18:40 INFO - -d DEST, --destination=DEST 15:18:40 INFO - Directory to install application into. [default: 15:18:40 INFO - "/builds/slave/test-pgo"] 15:18:40 INFO - --app=APP Application being installed. [default: firefox] 15:18:40 INFO - mkdir: /builds/slave/test-pgo/build/application 15:18:40 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'] 15:18:40 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 15:18:55 INFO - Reading from file tmpfile_stdout 15:18:55 INFO - Output received: 15:18:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:18:55 INFO - Running post-action listener: _resource_record_post_action 15:18:55 INFO - ##### 15:18:55 INFO - ##### Running run-tests step. 15:18:55 INFO - ##### 15:18:55 INFO - Running pre-action listener: _resource_record_pre_action 15:18:55 INFO - Running main action method: run_tests 15:18:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:18:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:18:55 INFO - Python 2.7.3 15:18:55 INFO - Return code: 0 15:18:55 INFO - grabbing minidump binary from tooltool 15:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:55 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 0x2c22d70>, '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 0x2c23b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c23fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:18:55 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 15:18:55 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 15:18:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:55 INFO - Return code: 0 15:18:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:18:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:18:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:18:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:18:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:18:55 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/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:18:55 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/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 15:18:55 INFO - Using env: {'DISPLAY': ':0', 15:18:55 INFO - 'HOME': '/home/cltbld', 15:18:55 INFO - 'LANG': 'en_US.UTF-8', 15:18:55 INFO - 'LANGUAGE': 'en_US:en', 15:18:55 INFO - 'LOGNAME': 'cltbld', 15:18:55 INFO - 'MAIL': '/var/mail/cltbld', 15:18:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:18:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:55 INFO - 'MOZ_NO_REMOTE': '1', 15:18:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:55 INFO - 'NO_EM_RESTART': '1', 15:18:55 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:18:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:18:55 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:18:55 INFO - 'SHELL': '/bin/bash', 15:18:55 INFO - 'SHLVL': '1', 15:18:55 INFO - 'TERM': 'linux', 15:18:55 INFO - 'TMOUT': '86400', 15:18:55 INFO - 'USER': 'cltbld', 15:18:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625', 15:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:55 INFO - '_': '/tools/buildbot/bin/python'} 15:18:55 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/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 15:18:55 INFO - mozversion INFO | application_buildid: 20151118143035 15:18:55 INFO - mozversion INFO | application_changeset: 24c5d435977da94d3986c89085496d8ddef6f1b2 15:18:55 INFO - mozversion INFO | application_display_name: Nightly 15:18:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:55 INFO - mozversion INFO | application_name: Firefox 15:18:55 INFO - mozversion INFO | application_remotingname: firefox 15:18:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:18:55 INFO - mozversion INFO | application_vendor: Mozilla 15:18:55 INFO - mozversion INFO | application_version: 45.0a1 15:18:55 INFO - mozversion INFO | platform_buildid: 20151118143035 15:18:55 INFO - mozversion INFO | platform_changeset: 24c5d435977da94d3986c89085496d8ddef6f1b2 15:18:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:18:55 INFO - mozversion INFO | platform_version: 45.0a1 15:18:55 INFO - 2015-11-18 15:18:55,626 DEBUG : using testdate: 1447888735 15:18:55 INFO - 2015-11-18 15:18:55,626 DEBUG : actual date: 1447888735 15:18:55 INFO - 2015-11-18 15:18:55,634 INFO : starting webserver on 'localhost:37116' 15:18:55 INFO - 2015-11-18 15:18:55,635 INFO : Starting test suite talos-linux64-ix-047.e 15:18:55 INFO - 2015-11-18 15:18:55,635 INFO : Starting test dromaeo_css 15:18:55 INFO - 2015-11-18 15:18:55,635 DEBUG : operating with platform_type : linux_ 15:18:55 INFO - 2015-11-18 15:18:55,636 INFO : Initialising browser for dromaeo_css test... 15:18:55 INFO - 2015-11-18 15:18:55,650 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt0ggew/profile http://localhost:37116/getInfo.html 15:19:01 INFO - 2015-11-18 15:19:01,198 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:19:01 INFO - 2015-11-18 15:19:01,198 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:19:01 INFO - 2015-11-18 15:19:01,198 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:19:01 INFO - 2015-11-18 15:19:01,198 DEBUG : BROWSER_OUTPUT: __metrics 15:19:02 INFO - 2015-11-18 15:19:02,185 INFO : Browser initialized. 15:19:02 INFO - 2015-11-18 15:19:02,186 INFO : Running cycle 1/1 for dromaeo_css test... 15:19:02 INFO - 2015-11-18 15:19:02,186 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt0ggew/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:19:14 INFO - 2015-11-18 15:19:13,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 141885440 15:19:14 INFO - 2015-11-18 15:19:14,000 DEBUG : BROWSER_OUTPUT: 15:20:03 INFO - 2015-11-18 15:20:03,598 DEBUG : BROWSER_OUTPUT: 1447888803596 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] 15:22:12 INFO - 2015-11-18 15:22:12,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37116/tests/dromaeo/cssquery-ext.html) 15:22:12 INFO - 2015-11-18 15:22:12,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 145219584 15:22:12 INFO - 2015-11-18 15:22:12,993 DEBUG : BROWSER_OUTPUT: 15:25:14 INFO - 2015-11-18 15:25:14,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/dromaeo/cssquery-ext.html (next: http://localhost:37116/tests/dromaeo/cssquery-jquery.html) 15:25:15 INFO - 2015-11-18 15:25:15,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 141225984 15:25:15 INFO - 2015-11-18 15:25:15,472 DEBUG : BROWSER_OUTPUT: 15:28:17 INFO - 2015-11-18 15:28:17,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37116/tests/dromaeo/cssquery-mootools.html) 15:28:17 INFO - 2015-11-18 15:28:17,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 141729792 15:28:17 INFO - 2015-11-18 15:28:17,679 DEBUG : BROWSER_OUTPUT: 15:31:19 INFO - 2015-11-18 15:31:19,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37116/tests/dromaeo/cssquery-prototype.html) 15:31:19 INFO - 2015-11-18 15:31:19,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 15:31:19 INFO - 2015-11-18 15:31:19,934 DEBUG : BROWSER_OUTPUT: 15:34:22 INFO - 2015-11-18 15:34:22,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37116/tests/dromaeo/cssquery-yui.html) 15:34:22 INFO - 2015-11-18 15:34:22,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 142348288 15:34:22 INFO - 2015-11-18 15:34:22,860 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/dromaeo/cssquery-yui.html (next: http://localhost:37116/tests/dromaeo/cssquery-dojo.html) 15:37:25 INFO - 2015-11-18 15:37:25,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 144441344 15:37:25 INFO - 2015-11-18 15:37:25,424 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,424 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:37:25 INFO - 2015-11-18 15:37:25,424 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:37:25 INFO - 2015-11-18 15:37:25,424 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:37:25 INFO - 2015-11-18 15:37:25,424 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:37:25 INFO - 2015-11-18 15:37:25,426 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3176.237702951292;3228.5157226416036;3248.220427097497;3260.934781304374;3272.280098378356;5110.488951104888;5303.098473259551;5345.091334473139;5353.919691204625;5361.142217245241;5255.185446255837;5265.3155089838265;5281.841544753664;5369.382521010085;5378;4879.585235254999;4937.5556199942;4982.725950072744;5002.924956125661;5047.974760126194;4901.975490122544;4964.826231081913;4988.226824842155;5020.799168033274;5033.068882256776;4775.379200703921;4822.590079843218;4926.187179115442;4944.406671199443;4966.47851975541;4903.552187378639;4908.705477671351;4910.852674419773;4914.238293064581;4924.729139897304;4863.8540843774745;4896.02079584081;4900.411950565919;4911.582515486188;4923.261510773413;4970.602351811846;5018.924716129261;5024.422191447994;5151.716655583941;5214.739263036871;5787.13193021046;5800.245968024172;5804.622699524517;5806.477417032487;5817.7382017809305;5784;5828.795992140254;5831.183634291203;5837.299524057098;5844.415558444121;5202.557782588485;5261.5790736741355;5295.867603309909;5352.277442545284;5373.811916582901;5815.563832712563;5843.035899076604;5857.092150716646;5864.032434648235;5880.500157486662;5436.456354364532;5687.943120568824;5691.146328050825;5692.345380281238;5700.714964251853;5662.348829884533;5681.318241811009;5781.306243250753;5788.18965344852;5844.9415505845245;5760.596758226884;5767.538596912237;5767.769289228468;5771.018926782457;5776.364599894008;5508.20131080991;5656.236408084856;5757;5765.711714414262;5769.394213607595;4340.370646256275;4379.934300985487;4384.56154384559;4417.116576684676;4423.093265880487;3961.7028722845903;4005.9799701001307;4008.899777505586;4018.035671438892;4040.777757223381;5288.576913846883;5293.814716484904;5372.301600791872;5541.695206763667;5577.2191893135;5781.682007489629;5801.506871915934;5833.125031245262;5846.29844418664;5881.617694849821;5575.553955683536;5593.748281327269;5596.132599447093;5596.608237423341;5603.691796951125;4854.05345957542;4931.260310953386;4962.925556116661;5047.066292735855;5067.6959382436435;5874.060150375919;5930.28836539618;5940.881182376328;5945.375735547792;5951.4941229995065;5741.598088133957;5759.308882934075;5768.884622307614;5771.769129234784;5777.94222057774;5809.883802324014;5855.151003104611;5931.1992880960515;5980.790672326448;6013.128096425906;5626.803061892814;5632.549396048388;5638;5640.943590564206;5661.575381846295;5500.917486237629;5727.713614319351;5728.885422291614;5750.30996280449;5759.913601296068;5523.475269849358;5535.363433205233;5607.467290607386;5615.971920140537;5649.180868774087;5587.106063029895;5624.409437009219;5650.519705825051;5668.574856885833;5671.602987790815;5419.3225846769155;5563.527100196528;5572;5581.665100094007;5589.692566908859;5539.723013849372;5556.222128901876;5591.552675785846;5604.355499117653;5606.607537472501;5431.565474762088;5441.918371224356;5468.863278417913;5469.371022332323;5478.205660179172 15:37:25 INFO - 2015-11-18 15:37:25,429 DEBUG : BROWSER_OUTPUT: |1;ext.html;576.1849979214803;596.4542443664047;608.0635820835913;609.9603525770827;612.7548980407838;31115.844420777892;39423.40864887025;39739.60260397395;39789.20421591566;40080.198396032065;42008.57991420085;42706.57293427073;42742;42792.14415711684;42849;8787.121287871225;8947.32895032875;8967.506787126706;8978.640854365818;8979.14698103679;8530.530820804885;8670.436421632605;8680.045195028573;8691.60887760049;8699.173578510063;8739.344549158839;8742.344324175681;8777.868331975025;8777.912220877774;8804.911950880472;8666.090060543615;8725.171108744658;8766.824663506726;8777.473351598925;8781.824363512758;8571.485710857369;8679.435836670596;8713.302935765123;8715.869261961076;8722.956385218033;39160.41259381112;39212.60787392118;39384.803075984724;39405.40891886624;39521;3313.088900552343;3357.8153201573905;3363.7140843028374;3436.7766095203733;3748.6626203641804;29528.852355738298;30121.548176777145;30258.69741302581;30361.24096897573;30486.695133048608;3222.935541289161;3268.7711860169798;3269.7874638148446;3281.6390197078304;3284.802911825298;258597;258695.9999999981;258792;259381.70309148522;260053;42677.35983960243;42968.570314296456;43037.569624303986;43299;56813.43186568082;43731.56268437275;44357;44532.3320150198;44545.55454445479;44650;13232.536861209812;13327.933360333136;13367.799483007762;13391.263480508665;13447.865521344856;11198.216124871344;11212.831807522894;11290.491927863266;11306.943465282786;11525.077993760478;14434.278286085653;14457.710845783025;14473.131612103307;14485.637859053608;14488.927555362156;6003.8198854034445;6023.759049638053;6064.483879030243;6069.332373438918;6072.7570897164505;969.6945462179391;970.1898914406408;978.9461579613189;1036.2487196782272;1097.9011888930036;28858.422831543252;28998.42003159925;29157.56263656047;29332.12003639894;32572.83713581417;1059.5391004912733;1095.430376204385;1133.2633788037842;1135.1316243074054;1152.625396746044;14943.850561494462;15607.921960390126;15727.4495392663;15798.36806527749;15807.288672009787;360040;362479;364430;366248;367160;53427.73286133545;53917.73041134769;54048.45951540434;54272.728636356565;54388.456115439134;1348.649351168703;1367.280995691717;1373.6771858613417;1380.4409214268237;1384.5431007767413;27838;28660.309193819867;29022.564661529672;29046.854765726035;29460.11619651414;47671.76164119157;48345.5165448341;48437.51562484471;48463.5153648459;48629.5137048625;293763;294062;296617;296634;297803;33484;45744.29088026922;46303;46599.30101048419;46975.53024469712;44504.77747611241;44551.55448445474;44674.10651787011;44922.3261651069;44935.32597010982;36989.815050924575;37435.2512949734;42188.578114218464;42870.35694464523;43622.56377436185;37720.62279377281;38426.807865960494;38689.41965870458;38827.61172388353;41049;36121.458178127876;36562.63437365592;36647;37312.253754924204;37489.625103748614;32264.83867580647;33922.32155356929;33967.15082122967;34200.69541513502;34839;26464.470710586065;27015;27167.320816979733;27386;28684.569731454463 15:37:25 INFO - 2015-11-18 15:37:25,429 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.9063352894718;347.85216283079694;350.107226572241;350.1491375956426;351.9137811236247;12065.879341206586;12426.192297500678;16744.497665070037;16988.74516882246;17522.73715894261;11415.086793056556;11470.02504787092;11479.942600287008;11700.414979251045;11908.464119114638;4442.11157768446;4533.659975501834;4550.203714349992;4567.08658268346;4570.040291538781;4393.956060439386;4526.117407105616;4536.251518499444;4544.500104988449;4562.406887104672;4575.542445755431;4577.748223847687;4594.724316541002;4665.393498845146;4770.117528257283;4672.415948006499;4699.624030077585;4706.199946009169;4714.151452738506;4714.387129673138;4063.1467391847746;4104.733192342488;4247;4274.081072569382;4286.207051695446;12660.620181394574;12843.29361885096;12882.291473968928;12938.48246070156;13275.137116087424;1884.2839720906104;1940.088158565472;1945.8443324534003;1949.3664559018375;2080.980319643364;9286.535673216313;9640.276979226515;9659.951700241523;9688.660896868647;9811.411315321104;1568.749000159969;1608.1959020489755;1624;1638.8361163883635;1686.5867862373675;56455.43544564543;58487.70756146192;59438.70280648569;59826.401735982516;60049.6997515014;6483.578567393104;6624.569402988886;6742.258351581322;6755.932440675629;6777.559458635173;8057.274845263954;8069.152738962324;8079.878801817978;8089.635966381527;8125.228103330174;5326.973365133227;5328.626996110313;5341.3857406398765;5403.8108666196495;5404.3784964728775;5331.546818520392;5340.599455040888;5349.5720342372515;5424.213489044067;5445.237666726662;3156.2898347871546;3187.713105820441;3198.440272952224;3229.128135403428;3236.4336241157703;1118.552578968403;1120.3110087296418;1123.9438028098562;1142.9714257143637;1174.5477990973366;415.65915948922196;421.08834373581465;423.99788001059795;464.5540281329961;481.8265424447196;9960.551775170135;10345.12066474343;10393.168546516412;10470.528826202839;10989.175811813986;434.2834323366408;441.30274166816355;447.3401732444618;457.95878370946775;465.17895913712323;5791.131330300404;5862;5928.081147422156;5990.311114221833;6001.669908155006;494592;500492;503623;512190;518339;74101.62949185328;76750.6162469184;77495;77579.2242077572;77986;470.89404883900846;474.0424342827469;476.7163537694997;476.8068932082512;478.99281510777365;9681;9711.611535538499;9739.951300243454;9835.16401105914;9883.11052005323;31171.220719481287;31651.20871978219;31891.173059233042;32796.508052378755;32917;46263.768681156376;46323.53676463327;47347;47757.52242477531;47797.283040755116;6726.091977582963;6757;6839.6580170990255;6841.794746157623;6841.931580684329;11796.469158888041;12050.698732531757;12070.155089144027;12101.092418068503;12213.267203967791;9895.950520247641;10566.101881340172;10676.83984740214;10742.8388574173;10891;2585.50875333686;9196.908030919605;10276.537555810157;10424.166066714797;10454.11140053104;10677.733056673645;10708.143348532254;10863.945680271549;10910.78178436411;10945.343279403261;6720.663966801738;6788.049673045679;6811.625360605214;6815.795526134224;6846.965765171142;10566.947165264124;10689.9465502672;10750.569977200825;10782.784344312913;10918 15:37:25 INFO - 2015-11-18 15:37:25,433 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1496.543554215964;1497.0568541818657;1655.8344165583444;1775.7513948047267;1776.333874796952;7581.469297149201;7676.270754278348;7691.115521715004;7733.690652373905;7853.175416581248;7750.573718445483;7806.414518911076;7837.255460731236;7875.409344299186;7915.881261781078;2229.398062523122;2245.494763678176;2255.8984845681903;2263.7170353705787;2266.1841736974675;2297.8391512594126;2336.8247381446376;2338.543983923127;2340.8010319122895;2342.26218741096;2208.282308249817;2262.7284725832924;2266.320103968811;2268.172117177235;2273.3180045986137;2186.431527802775;2256.706628138348;2279.179495381661;2280.623697089978;2281.3498153026308;2283.7716228377194;2303.9193628222934;2318.710161229846;2325.2094287942014;2329.2779238436137;7710.57591832449;7715.344195743369;7791.688332466694;7793.61031948406;7800.063992320901;4550.8862278442975;4603.12540617285;4623.190941585209;4641.628669706449;4654.348391225231;2924.093531005395;3001.0996700989617;3017.4266889290966;3052.6794686557814;3055.282008727947;962.0812124421161;973.2116985241977;999.5052449037701;1002.6891663584239;1011.3123076308108;10441.895581044168;10475.947620261926;10493.632722854663;10505.107065899409;10536.789264214749;4009.8396064157105;4058.7564746115327;4079.347304431277;4099.077707515785;4103.056297051695;8369.707060252862;8444.324454043663;8444.324454043663;8477.957610212034;8543.40196186261;4478.39541661878;4496.505384407713;4497.955020449819;4498.077894031716;4506.549345065468;4118.402831589463;4140;4151.543330233671;4168.353905144708;4174.5616710245595;3436.553248077784;3450.896473105811;3481.408160612651;3503.159241781954;3504.807235602066;1011.5397494140149;1036.8341065429495;1060.0459586372326;1065.2915810985762;1065.733566608348;992.245893121233;1033.4161198922734;1068.5351871935734;1111.7554138089608;1254.7553227120807;7033.542819716702;7063.187733410724;7078.115235595551;7109.715611375487;7141.642917854087;691.5228492340269;704.5279662626053;720.2473415281044;721.1706537481938;817.6729308276737;5588.2455868458055;5644.74598643062;5656.377798442168;5679.77280908759;5686.488216060575;8900.599473023729;9053.456792592466;9233.584488698025;9351.766205844771;9365.391249568756;9046.86429703555;9117;9120.771980700403;9132.497712625736;9170.633174672937;7013.509054366145;7025.648717564203;7064.258252883476;7155.141383034069;7196.172440169343;6841.486888483284;6888.345607167311;6903.413209877016;6917.654117294216;6956.513044086865;7983.441159118806;8097.190280971856;8114.188581141839;8158.673653053811;8160.714374996846;8175.264226219669;8314;8330.458520196167;8438.873416898628;8467.068622451403;6467.967660161858;6500.414962653194;6532.771353002622;6637.70130344126;6675.499337549606;7487.625618718933;7506.9249307506225;7513.849723005618;7524;7587.962060189664;6884.965575172092;6912.896306555305;6974.407175389946;6977.406920411822;7174.139103307428;6204.13142160089;6229.003359462465;6736.461083113437;6886.208086070166;6997.510174287751;6883.27725588826;6899.413549848118;6912.066870972354;6920.723171073302;6949.096617439701;6386.201724784402;6397.680115994089;6421.454176395058;6437.645929473737;6457.354264573505;6559.639219842764;6580.276169621242;6582.901256481253;6612.107365505595;6617.139771829631 15:37:25 INFO - 2015-11-18 15:37:25,434 DEBUG : BROWSER_OUTPUT: |4;prototype.html;326.86598494617203;331.3191391690076;334.30798247627405;334.7874099946536;338.3942742490941;6220.377962203777;6271.275399265199;6290.18227630408;6330.208723909512;6361.109444677743;6058.666773327465;6158.353372895848;6230.190075290206;6236.095766113911;6270.780522681707;4775.11660342836;4819.421669399677;4821.397325334333;4824.1316563018645;4826.806927722887;4795.592374648159;4801.90396192076;4812.855614331575;4819.614430845541;4833.105875413043;4690.742009189493;4765.28520721891;4768.856934291976;4777.928331075019;4788.233882578771;4732.408448943865;4738.47876733559;4760.690555113941;4773.0931123086675;4781.0676918001;4083.2854250506043;4182.602652747984;4183.91632167358;4185.22573323933;4222.959469182184;5919.112133180014;5949;5963.344032156459;5981.312149102865;5984.880302393928;5585.748641311151;5600.859978500529;5602.831915042555;5604.822987172699;5612.579056570733;6512.088307636935;6598.901016484757;6633.237177724575;6640.369164929372;6645.734170633169;4617.676762626617;4656.348111264426;4664.790084446208;4671.11248862715;4675.4155730533685;6859;6922;6934.237233904267;6936.79189624307;6940.271271516469;4740.601522550855;4769.618430525549;4772.832950846704;4803.519648035169;4806.158922188673;4739.857804265877;4777.784999675023;4779.402574678165;4853.296272040534;4874.098291815954;5511.311086114236;5514.61397702157;5519.69641669712;5536.557075434036;5542.445755424425;6687.331266873273;6687.498437617198;6702.430293425114;6705.329467053256;6707.5975441473665;1695.4828777223065;1714.1429285357322;1721.3286818140934;1721.8019927708224;1724.8706347024024;1102.9889701103048;1128.6331942118845;1129.8474705914596;1136.2500749505286;1169.1231576317762;6430.807075787734;6459.289478157399;6481.384268494486;6484.1246431731115;6506.804795856037;6833.658317084126;6856.382925536725;6876;6893.20728116273;6894.069300644349;6314.715837787218;6382.170317858741;6385.393387628168;6439.774607888701;6460.806175814733;3703.9258615001886;3746.512953316106;3747.4191500317493;3750.587435382106;3754.4743735876455;7101.325374089453;7191.352778249878;7205.279472052857;7317.414606831547;7336.559806411526;7180.497365184387;7197.0284011658805;7206.927930720731;7218.45861560385;7226.024486694229;7058.258882817333;7234.782956511313;7271.563706177646;7299.416046716144;7301.269873012762;6906.205786334636;6976.372126508639;6976.651167441709;6976.744186046561;6982;6893.448524117958;6920.93079069223;6932.376086152271;6937.410320122644;6946.374826265458;7119.288071192839;7258.745943891939;7287.526310789782;7299.4160467163565;7314.08573928259;4613.054323863667;4669.929951050669;4681.625469962463;4683.648726345469;4687.601553867959;6877.65611719402;6932.722691092502;6951.721931122698;6960.408365288805;6970.79087627372;6614.900776488453;6730.831729206809;6765.661716914233;6769.289224631343;6778;6713.731450741916;6728.192616886005;6732.360425759545;6758.560693554903;6763.797086087426;6585.1439312889015;6616.768413105518;6637.767678131242;6639.236487803964;6639.966800165968;6650.235222949423;6779.694913728796;6809.965950170217;6820.693068812015;6829;6592.571482853599;6621.172353455818;6627.834304142242;6628.105205797348;6647.6676166192465 15:37:25 INFO - 2015-11-18 15:37:25,434 DEBUG : BROWSER_OUTPUT: |5;yui.html;785.9646315915783;856.9571521423932;859.1022381611216;864.7665130414792;874.2030711220261;13503.527376541822;13586.592402227936;13586.728265434685;13637.659058523543;13798.586042418718;12877.806832897491;13548.93225533871;13594.388252528635;13631.045826792128;13635.795463068038;690.7685925215034;700.8318003679132;824.4558591329724;826.4710585225461;832.7002279179491;831.1522247307743;831.9209675080888;835.2566216067704;838.4382463749303;838.5220424358118;855.7860534866284;859.5315553023618;859.8925134358205;861.7199410191681;865.7532603208087;845.5349557743217;851.4848516647432;858.9613467393982;859.2266959736224;859.3383095016865;629.6190804563219;632.5066448170435;633.9239291285076;635.7647670361996;636.8567072408671;13609.59171224855;13742.65643358914;13748;13754.105983111065;13758.105723127965;12434.191777534521;12466.875331246662;12555.372231388485;12573.308468034254;12582.622521324374;9391.859122113174;9474.526273686288;9477.383970041994;9504.144626983536;9571.617135314578;3645.3073915956147;3646.2342907989087;3651.3610118229203;3652.105234217607;3661.2677464506937;47377.28934065992;47659;48514.27228591574;48583.27125093126;48809;9506.287028472892;9837;9844.507774611384;9877.209823214125;9929.950350248348;12856.29290389019;12925.676858078623;12988.675283117998;12994;12994.155379900276;6550.240042939313;6679.332066793282;6686.7993960181275;6730.32696730323;6852.349026842442;4166.291730405838;4203.285441474895;4206.326987681956;4228.9788551057045;4240.533541310453;2794.3572978215125;2796.6923638399758;2801.831890086601;2822.0122956964897;2827.7737780977473;459.7976890168315;462.0504862507512;462.722366580056;475.31554561431426;477.0125839512246;631.3844002097918;667.4026746062344;693.7051753004953;705.4250785609712;749.1796482851269;8959.5968181432;9393.859092113624;9619.470929098967;9729.70810875675;9731.270154738422;713.7537549545399;718.4647437658978;719.6042176802738;723.3092396761081;762.3177256355641;4045.352743561075;4056.8782936511952;4325.653947684178;4374.168907907488;4468.575485328888;56608;57312.42687573071;57571.42428575744;57631.71184144053;57771.422285777444;50265;51370.74314628403;51572.48427515677;51885.740571297654;51995.220071698954;46932.7653361731;47115.057698845834;47297.290540641916;48086.51913480891;48261.276080858814;8617.224449799549;8731.73804785832;8752.51861147643;8802.943646762173;8807.119288071142;34503.827480862434;34619;34809.47785783266;35100;35166;40701.59298406978;40707.59292407156;41915.1616967665;44764.552354476036;45202.54797451983;8554.700585479479;8704.173103555153;8711.085336039625;8895.73312800617;9065.95467022687;12640.876943430414;12656.74686506283;12813.359332033175;12842.35788210567;13001.089923705249;11104.777904442028;11227.607033753779;11273.7745245093;11274.943625281821;11708.121890858049;11489.195756296978;11558.422078895854;11636.825447618123;12054.337011464453;12195.451204695988;10425.530851111567;10868.293560918515;11215.271007384494;11303.491342889754;11787.646370608896;9545.570449329658;9787.706368808947;9912.385761071142;9937.155341796028;9943.900560994298;9325.30060245498;9882.654107106217;10041.096301332915;10086.394816311045;10111.39331640104 15:37:25 INFO - 2015-11-18 15:37:25,434 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:37:25 INFO - 2015-11-18 15:37:25,434 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: __startTimestamp1447889845422__endTimestamp 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:37:25 INFO - 2015-11-18 15:37:25,435 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,436 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5338.13 Median:5563.53 stddev:584.33 (10.5%) stddev-sans-first:560.97 15:37:25 INFO - 2015-11-18 15:37:25,436 DEBUG : BROWSER_OUTPUT: Values: 3176.2 3228.5 3248.2 3260.9 3272.3 5110.5 5303.1 5345.1 5353.9 5361.1 5255.2 5265.3 5281.8 5369.4 5378.0 4879.6 4937.6 4982.7 5002.9 5048.0 4902.0 4964.8 4988.2 5020.8 5033.1 4775.4 4822.6 4926.2 4944.4 4966.5 4903.6 4908.7 4910.9 4914.2 4924.7 4863.9 4896.0 4900.4 4911.6 4923.3 4970.6 5018.9 5024.4 5151.7 5214.7 5787.1 5800.2 5804.6 5806.5 5817.7 5784.0 5828.8 5831.2 5837.3 5844.4 5202.6 5261.6 5295.9 5352.3 5373.8 5815.6 5843.0 5857.1 5864.0 5880.5 5436.5 5687.9 5691.1 5692.3 5700.7 5662.3 5681.3 5781.3 5788.2 5844.9 5760.6 5767.5 5767.8 5771.0 5776.4 5508.2 5656.2 5757.0 5765.7 5769.4 4340.4 4379.9 4384.6 4417.1 4423.1 3961.7 4006.0 4008.9 4018.0 4040.8 5288.6 5293.8 5372.3 5541.7 5577.2 5781.7 5801.5 5833.1 5846.3 5881.6 5575.6 5593.7 5596.1 5596.6 5603.7 4854.1 4931.3 4962.9 5047.1 5067.7 5874.1 5930.3 5940.9 5945.4 5951.5 5741.6 5759.3 5768.9 5771.8 5777.9 5809.9 5855.2 5931.2 5980.8 6013.1 5626.8 5632.5 5638.0 5640.9 5661.6 5500.9 5727.7 5728.9 5750.3 5759.9 5523.5 5535.4 5607.5 5616.0 5649.2 5587.1 5624.4 5650.5 5668.6 5671.6 5419.3 5563.5 5572.0 5581.7 5589.7 5539.7 5556.2 5591.6 5604.4 5606.6 5431.6 5441.9 5468.9 5469.4 5478.2 15:37:25 INFO - 2015-11-18 15:37:25,436 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,436 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47265.85 Median:37605.12 stddev:81041.11 (215.5%) stddev-sans-first:81192.63 15:37:25 INFO - 2015-11-18 15:37:25,440 DEBUG : BROWSER_OUTPUT: Values: 576.2 596.5 608.1 610.0 612.8 31115.8 39423.4 39739.6 39789.2 40080.2 42008.6 42706.6 42742.0 42792.1 42849.0 8787.1 8947.3 8967.5 8978.6 8979.1 8530.5 8670.4 8680.0 8691.6 8699.2 8739.3 8742.3 8777.9 8777.9 8804.9 8666.1 8725.2 8766.8 8777.5 8781.8 8571.5 8679.4 8713.3 8715.9 8723.0 39160.4 39212.6 39384.8 39405.4 39521.0 3313.1 3357.8 3363.7 3436.8 3748.7 29528.9 30121.5 30258.7 30361.2 30486.7 3222.9 3268.8 3269.8 3281.6 3284.8 258597.0 258696.0 258792.0 259381.7 260053.0 42677.4 42968.6 43037.6 43299.0 56813.4 43731.6 44357.0 44532.3 44545.6 44650.0 13232.5 13327.9 13367.8 13391.3 13447.9 11198.2 11212.8 11290.5 11306.9 11525.1 14434.3 14457.7 14473.1 14485.6 14488.9 6003.8 6023.8 6064.5 6069.3 6072.8 969.7 970.2 978.9 1036.2 1097.9 28858.4 28998.4 29157.6 29332.1 32572.8 1059.5 1095.4 1133.3 1135.1 1152.6 14943.9 15607.9 15727.4 15798.4 15807.3 360040.0 362479.0 364430.0 366248.0 367160.0 53427.7 53917.7 54048.5 54272.7 54388.5 1348.6 1367.3 1373.7 1380.4 1384.5 27838.0 28660.3 29022.6 29046.9 29460.1 47671.8 48345.5 48437.5 48463.5 48629.5 293763.0 294062.0 296617.0 296634.0 297803.0 33484.0 45744.3 46303.0 46599.3 46975.5 44504.8 44551.6 44674.1 44922.3 44935.3 36989.8 37435.3 42188.6 42870.4 43622.6 37720.6 38426.8 38689.4 38827.6 41049.0 36121.5 36562.6 36647.0 37312.3 37489.6 32264.8 33922.3 33967.2 34200.7 34839.0 26464.5 27015.0 27167.3 27386.0 28684.6 15:37:25 INFO - 2015-11-18 15:37:25,440 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,440 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25559.14 Median:4564.75 stddev:83040.67 (1819.2%) stddev-sans-first:83252.04 15:37:25 INFO - 2015-11-18 15:37:25,440 DEBUG : BROWSER_OUTPUT: Values: 346.9 347.9 350.1 350.1 351.9 12065.9 12426.2 16744.5 16988.7 17522.7 11415.1 11470.0 11479.9 11700.4 11908.5 4442.1 4533.7 4550.2 4567.1 4570.0 4394.0 4526.1 4536.3 4544.5 4562.4 4575.5 4577.7 4594.7 4665.4 4770.1 4672.4 4699.6 4706.2 4714.2 4714.4 4063.1 4104.7 4247.0 4274.1 4286.2 12660.6 12843.3 12882.3 12938.5 13275.1 1884.3 1940.1 1945.8 1949.4 2081.0 9286.5 9640.3 9660.0 9688.7 9811.4 1568.7 1608.2 1624.0 1638.8 1686.6 56455.4 58487.7 59438.7 59826.4 60049.7 6483.6 6624.6 6742.3 6755.9 6777.6 8057.3 8069.2 8079.9 8089.6 8125.2 5327.0 5328.6 5341.4 5403.8 5404.4 5331.5 5340.6 5349.6 5424.2 5445.2 3156.3 3187.7 3198.4 3229.1 3236.4 1118.6 1120.3 1123.9 1143.0 1174.5 415.7 421.1 424.0 464.6 481.8 9960.6 10345.1 10393.2 10470.5 10989.2 434.3 441.3 447.3 458.0 465.2 5791.1 5862.0 5928.1 5990.3 6001.7 494592.0 500492.0 503623.0 512190.0 518339.0 74101.6 76750.6 77495.0 77579.2 77986.0 470.9 474.0 476.7 476.8 479.0 9681.0 9711.6 9740.0 9835.2 9883.1 31171.2 31651.2 31891.2 32796.5 32917.0 46263.8 46323.5 47347.0 47757.5 47797.3 6726.1 6757.0 6839.7 6841.8 6841.9 11796.5 12050.7 12070.2 12101.1 12213.3 9896.0 10566.1 10676.8 10742.8 10891.0 2585.5 9196.9 10276.5 10424.2 10454.1 10677.7 10708.1 10863.9 10910.8 10945.3 6720.7 6788.0 6811.6 6815.8 6847.0 10566.9 10689.9 10750.6 10782.8 10918.0 15:37:25 INFO - 2015-11-18 15:37:25,441 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,441 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5334.99 Median:6546.21 stddev:2769.42 (42.3%) stddev-sans-first:2762.16 15:37:25 INFO - 2015-11-18 15:37:25,441 DEBUG : BROWSER_OUTPUT: Values: 1496.5 1497.1 1655.8 1775.8 1776.3 7581.5 7676.3 7691.1 7733.7 7853.2 7750.6 7806.4 7837.3 7875.4 7915.9 2229.4 2245.5 2255.9 2263.7 2266.2 2297.8 2336.8 2338.5 2340.8 2342.3 2208.3 2262.7 2266.3 2268.2 2273.3 2186.4 2256.7 2279.2 2280.6 2281.3 2283.8 2303.9 2318.7 2325.2 2329.3 7710.6 7715.3 7791.7 7793.6 7800.1 4550.9 4603.1 4623.2 4641.6 4654.3 2924.1 3001.1 3017.4 3052.7 3055.3 962.1 973.2 999.5 1002.7 1011.3 10441.9 10475.9 10493.6 10505.1 10536.8 4009.8 4058.8 4079.3 4099.1 4103.1 8369.7 8444.3 8444.3 8478.0 8543.4 4478.4 4496.5 4498.0 4498.1 4506.5 4118.4 4140.0 4151.5 4168.4 4174.6 3436.6 3450.9 3481.4 3503.2 3504.8 1011.5 1036.8 1060.0 1065.3 1065.7 992.2 1033.4 1068.5 1111.8 1254.8 7033.5 7063.2 7078.1 7109.7 7141.6 691.5 704.5 720.2 721.2 817.7 5588.2 5644.7 5656.4 5679.8 5686.5 8900.6 9053.5 9233.6 9351.8 9365.4 9046.9 9117.0 9120.8 9132.5 9170.6 7013.5 7025.6 7064.3 7155.1 7196.2 6841.5 6888.3 6903.4 6917.7 6956.5 7983.4 8097.2 8114.2 8158.7 8160.7 8175.3 8314.0 8330.5 8438.9 8467.1 6468.0 6500.4 6532.8 6637.7 6675.5 7487.6 7506.9 7513.8 7524.0 7588.0 6885.0 6912.9 6974.4 6977.4 7174.1 6204.1 6229.0 6736.5 6886.2 6997.5 6883.3 6899.4 6912.1 6920.7 6949.1 6386.2 6397.7 6421.5 6437.6 6457.4 6559.6 6580.3 6582.9 6612.1 6617.1 15:37:25 INFO - 2015-11-18 15:37:25,441 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,442 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5609.07 Median:6371.64 stddev:1705.29 (26.8%) stddev-sans-first:1663.35 15:37:25 INFO - 2015-11-18 15:37:25,443 DEBUG : BROWSER_OUTPUT: Values: 326.9 331.3 334.3 334.8 338.4 6220.4 6271.3 6290.2 6330.2 6361.1 6058.7 6158.4 6230.2 6236.1 6270.8 4775.1 4819.4 4821.4 4824.1 4826.8 4795.6 4801.9 4812.9 4819.6 4833.1 4690.7 4765.3 4768.9 4777.9 4788.2 4732.4 4738.5 4760.7 4773.1 4781.1 4083.3 4182.6 4183.9 4185.2 4223.0 5919.1 5949.0 5963.3 5981.3 5984.9 5585.7 5600.9 5602.8 5604.8 5612.6 6512.1 6598.9 6633.2 6640.4 6645.7 4617.7 4656.3 4664.8 4671.1 4675.4 6859.0 6922.0 6934.2 6936.8 6940.3 4740.6 4769.6 4772.8 4803.5 4806.2 4739.9 4777.8 4779.4 4853.3 4874.1 5511.3 5514.6 5519.7 5536.6 5542.4 6687.3 6687.5 6702.4 6705.3 6707.6 1695.5 1714.1 1721.3 1721.8 1724.9 1103.0 1128.6 1129.8 1136.3 1169.1 6430.8 6459.3 6481.4 6484.1 6506.8 6833.7 6856.4 6876.0 6893.2 6894.1 6314.7 6382.2 6385.4 6439.8 6460.8 3703.9 3746.5 3747.4 3750.6 3754.5 7101.3 7191.4 7205.3 7317.4 7336.6 7180.5 7197.0 7206.9 7218.5 7226.0 7058.3 7234.8 7271.6 7299.4 7301.3 6906.2 6976.4 6976.7 6976.7 6982.0 6893.4 6920.9 6932.4 6937.4 6946.4 7119.3 7258.7 7287.5 7299.4 7314.1 4613.1 4669.9 4681.6 4683.6 4687.6 6877.7 6932.7 6951.7 6960.4 6970.8 6614.9 6730.8 6765.7 6769.3 6778.0 6713.7 6728.2 6732.4 6758.6 6763.8 6585.1 6616.8 6637.8 6639.2 6640.0 6650.2 6779.7 6810.0 6820.7 6829.0 6592.6 6621.2 6627.8 6628.1 6647.7 15:37:25 INFO - 2015-11-18 15:37:25,443 DEBUG : BROWSER_OUTPUT: 15:37:25 INFO - 2015-11-18 15:37:25,445 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13601.17 Median:48548.77 stddev:15910.55 (32.8%) stddev-sans-first:15926.08 15:37:25 INFO - 2015-11-18 15:37:25,446 DEBUG : BROWSER_OUTPUT: Values: 786.0 857.0 859.1 864.8 874.2 13503.5 13586.6 13586.7 13637.7 13798.6 12877.8 13548.9 13594.4 13631.0 13635.8 690.8 700.8 824.5 826.5 832.7 831.2 831.9 835.3 838.4 838.5 855.8 859.5 859.9 861.7 865.8 845.5 851.5 859.0 859.2 859.3 629.6 632.5 633.9 635.8 636.9 13609.6 13742.7 13748.0 13754.1 13758.1 12434.2 12466.9 12555.4 12573.3 12582.6 9391.9 9474.5 9477.4 9504.1 9571.6 3645.3 3646.2 3651.4 3652.1 3661.3 47377.3 47659.0 48514.3 48583.3 48809.0 9506.3 9837.0 9844.5 9877.2 9930.0 12856.3 12925.7 12988.7 12994.0 12994.2 6550.2 6679.3 6686.8 6730.3 6852.3 4166.3 4203.3 4206.3 4229.0 4240.5 2794.4 2796.7 2801.8 2822.0 2827.8 459.8 462.1 462.7 475.3 477.0 631.4 667.4 693.7 705.4 749.2 8959.6 9393.9 9619.5 9729.7 9731.3 713.8 718.5 719.6 723.3 762.3 4045.4 4056.9 4325.7 4374.2 4468.6 56608.0 57312.4 57571.4 57631.7 57771.4 50265.0 51370.7 51572.5 51885.7 51995.2 46932.8 47115.1 47297.3 48086.5 48261.3 8617.2 8731.7 8752.5 8802.9 8807.1 34503.8 34619.0 34809.5 35100.0 35166.0 40701.6 40707.6 41915.2 44764.6 45202.5 8554.7 8704.2 8711.1 8895.7 9066.0 12640.9 12656.7 12813.4 12842.4 13001.1 11104.8 11227.6 11273.8 11274.9 11708.1 11489.2 11558.4 11636.8 12054.3 12195.5 10425.5 10868.3 11215.3 11303.5 11787.6 9545.6 9787.7 9912.4 9937.2 9943.9 9325.3 9882.7 10041.1 10086.4 10111.4 15:37:25 INFO - 2015-11-18 15:37:25,446 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:37:25 INFO - 2015-11-18 15:37:25,446 DEBUG : BROWSER_OUTPUT: 15:37:26 INFO - 2015-11-18 15:37:26,085 INFO : Browser exited with error code: 0 15:37:26 INFO - 2015-11-18 15:37:26,102 INFO : Completed test dromaeo_css (00:18:30) 15:37:26 INFO - 2015-11-18 15:37:26,102 INFO : Starting test kraken 15:37:26 INFO - 2015-11-18 15:37:26,102 DEBUG : operating with platform_type : linux_ 15:37:26 INFO - 2015-11-18 15:37:26,102 INFO : Initialising browser for kraken test... 15:37:26 INFO - 2015-11-18 15:37:26,108 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLskdjE/profile http://localhost:37116/getInfo.html 15:37:30 INFO - 2015-11-18 15:37:30,679 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:37:30 INFO - 2015-11-18 15:37:30,679 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:37:30 INFO - 2015-11-18 15:37:30,679 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:37:30 INFO - 2015-11-18 15:37:30,679 DEBUG : BROWSER_OUTPUT: __metrics 15:37:31 INFO - 2015-11-18 15:37:31,713 INFO : Browser initialized. 15:37:31 INFO - 2015-11-18 15:37:31,714 INFO : Running cycle 1/1 for kraken test... 15:37:31 INFO - 2015-11-18 15:37:31,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLskdjE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:37:43 INFO - 2015-11-18 15:37:43,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 15:37:43 INFO - 2015-11-18 15:37:43,527 DEBUG : BROWSER_OUTPUT: 15:37:46 INFO - 2015-11-18 15:37:46,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37116/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:46 INFO - 2015-11-18 15:37:46,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 142516224 15:37:46 INFO - 2015-11-18 15:37:46,621 DEBUG : BROWSER_OUTPUT: 15:37:49 INFO - 2015-11-18 15:37:49,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37116/tests/kraken/driver.html?testName=audio-dft) 15:37:49 INFO - 2015-11-18 15:37:49,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 15:37:49 INFO - 2015-11-18 15:37:49,845 DEBUG : BROWSER_OUTPUT: 15:37:52 INFO - 2015-11-18 15:37:52,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37116/tests/kraken/driver.html?testName=audio-fft) 15:37:53 INFO - 2015-11-18 15:37:53,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 137768960 15:37:53 INFO - 2015-11-18 15:37:53,253 DEBUG : BROWSER_OUTPUT: 15:37:55 INFO - 2015-11-18 15:37:55,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37116/tests/kraken/driver.html?testName=audio-oscillator) 15:37:55 INFO - 2015-11-18 15:37:55,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 138027008 15:37:55 INFO - 2015-11-18 15:37:55,867 DEBUG : BROWSER_OUTPUT: 15:37:58 INFO - 2015-11-18 15:37:58,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37116/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:58 INFO - 2015-11-18 15:37:58,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 136884224 15:37:58 INFO - 2015-11-18 15:37:58,622 DEBUG : BROWSER_OUTPUT: 15:38:01 INFO - 2015-11-18 15:38:01,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37116/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:02 INFO - 2015-11-18 15:38:02,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 137461760 15:38:02 INFO - 2015-11-18 15:38:02,210 DEBUG : BROWSER_OUTPUT: 15:38:05 INFO - 2015-11-18 15:38:05,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37116/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:06 INFO - 2015-11-18 15:38:06,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 138661888 15:38:06 INFO - 2015-11-18 15:38:06,179 DEBUG : BROWSER_OUTPUT: 15:38:09 INFO - 2015-11-18 15:38:09,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37116/tests/kraken/driver.html?testName=json-parse-financial) 15:38:09 INFO - 2015-11-18 15:38:09,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 15:38:09 INFO - 2015-11-18 15:38:09,620 DEBUG : BROWSER_OUTPUT: 15:38:11 INFO - 2015-11-18 15:38:11,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37116/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:11 INFO - 2015-11-18 15:38:11,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 15:38:11 INFO - 2015-11-18 15:38:11,791 DEBUG : BROWSER_OUTPUT: 15:38:13 INFO - 2015-11-18 15:38:13,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:14 INFO - 2015-11-18 15:38:14,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 138395648 15:38:14 INFO - 2015-11-18 15:38:14,219 DEBUG : BROWSER_OUTPUT: 15:38:16 INFO - 2015-11-18 15:38:16,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:16 INFO - 2015-11-18 15:38:16,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 140582912 15:38:16 INFO - 2015-11-18 15:38:16,911 DEBUG : BROWSER_OUTPUT: 15:38:19 INFO - 2015-11-18 15:38:19,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:19 INFO - 2015-11-18 15:38:19,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 15:38:19 INFO - 2015-11-18 15:38:19,979 DEBUG : BROWSER_OUTPUT: 15:38:22 INFO - 2015-11-18 15:38:22,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:23 INFO - 2015-11-18 15:38:23,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 138276864 15:38:23 INFO - 2015-11-18 15:38:23,147 DEBUG : BROWSER_OUTPUT: 15:38:24 INFO - 2015-11-18 15:38:24,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37116/tests/kraken/driver.html?testName=ai-astar) 15:38:25 INFO - 2015-11-18 15:38:25,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 140853248 15:38:25 INFO - 2015-11-18 15:38:25,080 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,080 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:38:25 INFO - 2015-11-18 15:38:25,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:38:25 INFO - 2015-11-18 15:38:25,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:38:25 INFO - 2015-11-18 15:38:25,081 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:38:25 INFO - 2015-11-18 15:38:25,081 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;106;111;112;112;124;110;111;111;111 15:38:25 INFO - 2015-11-18 15:38:25,081 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;133;154;170;127;148;148;128;164;128 15:38:25 INFO - 2015-11-18 15:38:25,081 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;159;161;162;161;161;165;169;162 15:38:25 INFO - 2015-11-18 15:38:25,081 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;72;72;72;148;76;72;73 15:38:25 INFO - 2015-11-18 15:38:25,081 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;90;130;90;91;92;130;91;91;140 15:38:25 INFO - 2015-11-18 15:38:25,082 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;111;110;109;110;111 15:38:25 INFO - 2015-11-18 15:38:25,082 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;146;146;148;147;146;148;146;146 15:38:25 INFO - 2015-11-18 15:38:25,082 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;97;96;97;96;96;96;96 15:38:25 INFO - 2015-11-18 15:38:25,082 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;61;61;62;62;62;61;62;65;60 15:38:25 INFO - 2015-11-18 15:38:25,082 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;69;69;70;69;69 15:38:25 INFO - 2015-11-18 15:38:25,082 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;87;86;84;93;85;84;87;85 15:38:25 INFO - 2015-11-18 15:38:25,083 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;121;123;120;126;127;119;121;123;127 15:38:25 INFO - 2015-11-18 15:38:25,083 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;139;149;152;153;165;154;151;150;141 15:38:25 INFO - 2015-11-18 15:38:25,083 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;69;70;70;68;68;70;67;69 15:38:25 INFO - 2015-11-18 15:38:25,083 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:38:25 INFO - 2015-11-18 15:38:25,083 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:38:25 INFO - 2015-11-18 15:38:25,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,724 15:38:25 INFO - 2015-11-18 15:38:25,085 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:38:25 INFO - 2015-11-18 15:38:25,085 DEBUG : BROWSER_OUTPUT: __startTimestamp1447889905079__endTimestamp 15:38:25 INFO - 2015-11-18 15:38:25,085 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,088 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:111.50 stddev:4.61 (4.1%) stddev-sans-first:4.85 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: Values: 114.0 106.0 111.0 112.0 112.0 124.0 110.0 111.0 111.0 111.0 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:149.00 stddev:15.48 (10.4%) stddev-sans-first:16.31 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: Values: 150.0 133.0 154.0 170.0 127.0 148.0 148.0 128.0 164.0 128.0 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 159.0 161.0 162.0 161.0 161.0 165.0 169.0 162.0 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:72.00 stddev:23.86 (33.1%) stddev-sans-first:25.12 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 72.0 72.0 148.0 76.0 72.0 73.0 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,089 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:91.00 stddev:20.64 (22.7%) stddev-sans-first:21.45 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: Values: 92.0 90.0 130.0 90.0 91.0 92.0 130.0 91.0 91.0 140.0 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 111.0 110.0 109.0 110.0 111.0 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 146.0 146.0 148.0 147.0 146.0 148.0 146.0 146.0 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:1.32 (2.1%) stddev-sans-first:1.39 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 65.0 60.0 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 15:38:25 INFO - 2015-11-18 15:38:25,090 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:2.69 (3.1%) stddev-sans-first:2.74 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 87.0 86.0 84.0 93.0 85.0 84.0 87.0 85.0 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:4.51 (3.6%) stddev-sans-first:3.04 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: Values: 134.0 121.0 123.0 120.0 126.0 127.0 119.0 121.0 123.0 127.0 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.50 stddev:7.41 (4.9%) stddev-sans-first:7.55 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: Values: 144.0 139.0 149.0 152.0 153.0 165.0 154.0 151.0 150.0 141.0 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.10 (1.6%) stddev-sans-first:1.09 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 70.0 70.0 68.0 68.0 70.0 67.0 69.0 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:38:25 INFO - 2015-11-18 15:38:25,091 DEBUG : BROWSER_OUTPUT: 15:38:26 INFO - 2015-11-18 15:38:26,001 INFO : Browser exited with error code: 0 15:38:26 INFO - 2015-11-18 15:38:26,049 INFO : Completed test kraken (00:00:59) 15:38:26 INFO - 2015-11-18 15:38:26,049 INFO : Starting test v8_7 15:38:26 INFO - 2015-11-18 15:38:26,049 DEBUG : operating with platform_type : linux_ 15:38:26 INFO - 2015-11-18 15:38:26,049 INFO : Initialising browser for v8_7 test... 15:38:26 INFO - 2015-11-18 15:38:26,055 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOdelJi/profile http://localhost:37116/getInfo.html 15:38:30 INFO - 2015-11-18 15:38:30,420 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:38:30 INFO - 2015-11-18 15:38:30,420 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:38:30 INFO - 2015-11-18 15:38:30,420 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:38:30 INFO - 2015-11-18 15:38:30,420 DEBUG : BROWSER_OUTPUT: __metrics 15:38:31 INFO - 2015-11-18 15:38:31,477 INFO : Browser initialized. 15:38:31 INFO - 2015-11-18 15:38:31,478 INFO : Running cycle 1/1 for v8_7 test... 15:38:31 INFO - 2015-11-18 15:38:31,478 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOdelJi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:38:43 INFO - 2015-11-18 15:38:43,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 142532608 15:38:43 INFO - 2015-11-18 15:38:43,259 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37116/tests/v8_7/run.html (next: http://localhost:37116/tests/v8_7/run.html) 15:39:04 INFO - 2015-11-18 15:39:04,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 138883072 15:39:04 INFO - 2015-11-18 15:39:04,955 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,956 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:39:04 INFO - 2015-11-18 15:39:04,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:39:04 INFO - 2015-11-18 15:39:04,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:39:04 INFO - 2015-11-18 15:39:04,956 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:39:04 INFO - 2015-11-18 15:39:04,956 DEBUG : BROWSER_OUTPUT: |0;Richards;166.22340425531914 15:39:04 INFO - 2015-11-18 15:39:04,956 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.8649270913277 15:39:04 INFO - 2015-11-18 15:39:04,957 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.88543140028287 15:39:04 INFO - 2015-11-18 15:39:04,957 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 15:39:04 INFO - 2015-11-18 15:39:04,957 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 15:39:04 INFO - 2015-11-18 15:39:04,957 DEBUG : BROWSER_OUTPUT: |5;Earley;718.9072609633357 15:39:04 INFO - 2015-11-18 15:39:04,957 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 15:39:04 INFO - 2015-11-18 15:39:04,957 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 15:39:04 INFO - 2015-11-18 15:39:04,958 DEBUG : BROWSER_OUTPUT: |8;Splay;594.5303210463734 15:39:04 INFO - 2015-11-18 15:39:04,958 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 15:39:04 INFO - 2015-11-18 15:39:04,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:39:04 INFO - 2015-11-18 15:39:04,958 DEBUG : BROWSER_OUTPUT: __startTimestamp1447889944953__endTimestamp 15:39:04 INFO - 2015-11-18 15:39:04,958 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,958 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:39:04 INFO - 2015-11-18 15:39:04,959 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:39:04 INFO - 2015-11-18 15:39:04,959 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,959 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,959 DEBUG : BROWSER_OUTPUT: Values: 166.2 15:39:04 INFO - 2015-11-18 15:39:04,959 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,959 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.86 Median:191.86 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,960 DEBUG : BROWSER_OUTPUT: Values: 191.9 15:39:04 INFO - 2015-11-18 15:39:04,960 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,960 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,960 DEBUG : BROWSER_OUTPUT: Values: 282.9 15:39:04 INFO - 2015-11-18 15:39:04,960 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: Values: 5055.6 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: Values: 1063.8 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:718.91 Median:718.91 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: Values: 718.9 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: Values: 12419.8 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,962 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: Values: 25200.0 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.53 Median:594.53 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: Values: 594.5 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: Values: 4835.7 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:39:04 INFO - 2015-11-18 15:39:04,963 DEBUG : BROWSER_OUTPUT: 15:39:05 INFO - 2015-11-18 15:39:05,913 INFO : Browser exited with error code: 0 15:39:05 INFO - 2015-11-18 15:39:05,932 INFO : Completed test v8_7 (00:00:39) 15:39:05 INFO - 2015-11-18 15:39:05,992 INFO : Completed test suite (00:20:10) 15:39:05 INFO - 2015-11-18 15:39:05,992 DEBUG : Working with test: dromaeo_css 15:39:05 INFO - 2015-11-18 15:39:05,992 DEBUG : Generating results file: dromaeo_css 15:39:05 INFO - 2015-11-18 15:39:05,994 DEBUG : Working with test: kraken 15:39:05 INFO - 2015-11-18 15:39:05,994 DEBUG : Generating results file: kraken 15:39:05 INFO - 2015-11-18 15:39:05,994 INFO : javascript benchmark 15:39:05 INFO - 2015-11-18 15:39:05,994 DEBUG : Working with test: v8_7 15:39:05 INFO - 2015-11-18 15:39:05,994 DEBUG : Generating results file: v8_7 15:39:05 INFO - 2015-11-18 15:39:05,995 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:39:06 INFO - 2015-11-18 15:39:06,044 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 15:39:06 INFO - 2015-11-18 15:39:06,044 DEBUG : process_Request line: dromaeo_css 6660.71 graph.html#tests=[[72,64,43]] 15:39:06 INFO - 2015-11-18 15:39:06,045 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:39:06 INFO - 2015-11-18 15:39:06,085 DEBUG : process_Request line: kraken 1515.40 graph.html#tests=[[232,64,43]] 15:39:06 INFO - 2015-11-18 15:39:06,085 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:39:06 INFO - 2015-11-18 15:39:06,118 DEBUG : process_Request line: v8_7 21368.44 graph.html#tests=[[230,64,43]] 15:39:06 INFO - 2015-11-18 15:39:06,119 INFO : javascript benchmark 15:39:06 INFO - 2015-11-18 15:39:06,123 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3176.237702951292, 3228.5157226416036, 3248.220427097497, 3260.934781304374, 3272.280098378356, 5110.488951104888, 5303.098473259551, 5345.091334473139, 5353.919691204625, 5361.142217245241, 5255.185446255837, 5265.3155089838265, 5281.841544753664, 5369.382521010085, 5378.0, 4879.585235254999, 4937.5556199942, 4982.725950072744, 5002.924956125661, 5047.974760126194, 4901.975490122544, 4964.826231081913, 4988.226824842155, 5020.799168033274, 5033.068882256776, 4775.379200703921, 4822.590079843218, 4926.187179115442, 4944.406671199443, 4966.47851975541, 4903.552187378639, 4908.705477671351, 4910.852674419773, 4914.238293064581, 4924.729139897304, 4863.8540843774745, 4896.02079584081, 4900.411950565919, 4911.582515486188, 4923.261510773413, 4970.602351811846, 5018.924716129261, 5024.422191447994, 5151.716655583941, 5214.739263036871, 5787.13193021046, 5800.245968024172, 5804.622699524517, 5806.477417032487, 5817.7382017809305, 5784.0, 5828.795992140254, 5831.183634291203, 5837.299524057098, 5844.415558444121, 5202.557782588485, 5261.5790736741355, 5295.867603309909, 5352.277442545284, 5373.811916582901, 5815.563832712563, 5843.035899076604, 5857.092150716646, 5864.032434648235, 5880.500157486662, 5436.456354364532, 5687.943120568824, 5691.146328050825, 5692.345380281238, 5700.714964251853, 5662.348829884533, 5681.318241811009, 5781.306243250753, 5788.18965344852, 5844.9415505845245, 5760.596758226884, 5767.538596912237, 5767.769289228468, 5771.018926782457, 5776.364599894008, 5508.20131080991, 5656.236408084856, 5757.0, 5765.711714414262, 5769.394213607595, 4340.370646256275, 4379.934300985487, 4384.56154384559, 4417.116576684676, 4423.093265880487, 3961.7028722845903, 4005.9799701001307, 4008.899777505586, 4018.035671438892, 4040.777757223381, 5288.576913846883, 5293.814716484904, 5372.301600791872, 5541.695206763667, 5577.2191893135, 5781.682007489629, 5801.506871915934, 5833.125031245262, 5846.29844418664, 5881.617694849821, 5575.553955683536, 5593.748281327269, 5596.132599447093, 5596.608237423341, 5603.691796951125, 4854.05345957542, 4931.260310953386, 4962.925556116661, 5047.066292735855, 5067.6959382436435, 5874.060150375919, 5930.28836539618, 5940.881182376328, 5945.375735547792, 5951.4941229995065, 5741.598088133957, 5759.308882934075, 5768.884622307614, 5771.769129234784, 5777.94222057774, 5809.883802324014, 5855.151003104611, 5931.1992880960515, 5980.790672326448, 6013.128096425906, 5626.803061892814, 5632.549396048388, 5638.0, 5640.943590564206, 5661.575381846295, 5500.917486237629, 5727.713614319351, 5728.885422291614, 5750.30996280449, 5759.913601296068, 5523.475269849358, 5535.363433205233, 5607.467290607386, 5615.971920140537, 5649.180868774087, 5587.106063029895, 5624.409437009219, 5650.519705825051, 5668.574856885833, 5671.602987790815, 5419.3225846769155, 5563.527100196528, 5572.0, 5581.665100094007, 5589.692566908859, 5539.723013849372, 5556.222128901876, 5591.552675785846, 5604.355499117653, 5606.607537472501, 5431.565474762088, 5441.918371224356, 5468.863278417913, 5469.371022332323, 5478.205660179172], "unit": "ms", "name": "dojo.html", "value": 5300.98648791345}, {"lowerIsBetter": false, "replicates": [576.1849979214803, 596.4542443664047, 608.0635820835913, 609.9603525770827, 612.7548980407838, 31115.844420777892, 39423.40864887025, 39739.60260397395, 39789.20421591566, 40080.198396032065, 42008.57991420085, 42706.57293427073, 42742.0, 42792.14415711684, 42849.0, 8787.121287871225, 8947.32895032875, 8967.506787126706, 8978.640854365818, 8979.14698103679, 8530.530820804885, 8670.436421632605, 8680.045195028573, 8691.60887760049, 8699.173578510063, 8739.344549158839, 8742.344324175681, 8777.868331975025, 8777.912220877774, 8804.911950880472, 8666.090060543615, 8725.171108744658, 8766.824663506726, 8777.473351598925, 8781.824363512758, 8571.485710857369, 8679.435836670596, 8713.302935765123, 8715.869261961076, 8722.956385218033, 39160.41259381112, 39212.60787392118, 39384.803075984724, 39405.40891886624, 39521.0, 3313.088900552343, 3357.8153201573905, 3363.7140843028374, 3436.7766095203733, 3748.6626203641804, 29528.852355738298, 30121.548176777145, 30258.69741302581, 30361.24096897573, 30486.695133048608, 3222.935541289161, 3268.7711860169798, 3269.7874638148446, 3281.6390197078304, 3284.802911825298, 258597.0, 258695.9999999981, 258792.0, 259381.70309148522, 260053.0, 42677.35983960243, 42968.570314296456, 43037.569624303986, 43299.0, 56813.43186568082, 43731.56268437275, 44357.0, 44532.3320150198, 44545.55454445479, 44650.0, 13232.536861209812, 13327.933360333136, 13367.799483007762, 13391.263480508665, 13447.865521344856, 11198.216124871344, 11212.831807522894, 11290.491927863266, 11306.943465282786, 11525.077993760478, 14434.278286085653, 14457.710845783025, 14473.131612103307, 14485.637859053608, 14488.927555362156, 6003.8198854034445, 6023.759049638053, 6064.483879030243, 6069.332373438918, 6072.7570897164505, 969.6945462179391, 970.1898914406408, 978.9461579613189, 1036.2487196782272, 1097.9011888930036, 28858.422831543252, 28998.42003159925, 29157.56263656047, 29332.12003639894, 32572.83713581417, 1059.5391004912733, 1095.430376204385, 1133.2633788037842, 1135.1316243074054, 1152.625396746044, 14943.850561494462, 15607.921960390126, 15727.4495392663, 15798.36806527749, 15807.288672009787, 360040.0, 362479.0, 364430.0, 366248.0, 367160.0, 53427.73286133545, 53917.73041134769, 54048.45951540434, 54272.728636356565, 54388.456115439134, 1348.649351168703, 1367.280995691717, 1373.6771858613417, 1380.4409214268237, 1384.5431007767413, 27838.0, 28660.309193819867, 29022.564661529672, 29046.854765726035, 29460.11619651414, 47671.76164119157, 48345.5165448341, 48437.51562484471, 48463.5153648459, 48629.5137048625, 293763.0, 294062.0, 296617.0, 296634.0, 297803.0, 33484.0, 45744.29088026922, 46303.0, 46599.30101048419, 46975.53024469712, 44504.77747611241, 44551.55448445474, 44674.10651787011, 44922.3261651069, 44935.32597010982, 36989.815050924575, 37435.2512949734, 42188.578114218464, 42870.35694464523, 43622.56377436185, 37720.62279377281, 38426.807865960494, 38689.41965870458, 38827.61172388353, 41049.0, 36121.458178127876, 36562.63437365592, 36647.0, 37312.253754924204, 37489.625103748614, 32264.83867580647, 33922.32155356929, 33967.15082122967, 34200.69541513502, 34839.0, 26464.470710586065, 27015.0, 27167.320816979733, 27386.0, 28684.569731454463], "unit": "ms", "name": "ext.html", "value": 18308.99590371985}, {"lowerIsBetter": false, "replicates": [346.9063352894718, 347.85216283079694, 350.107226572241, 350.1491375956426, 351.9137811236247, 12065.879341206586, 12426.192297500678, 16744.497665070037, 16988.74516882246, 17522.73715894261, 11415.086793056556, 11470.02504787092, 11479.942600287008, 11700.414979251045, 11908.464119114638, 4442.11157768446, 4533.659975501834, 4550.203714349992, 4567.08658268346, 4570.040291538781, 4393.956060439386, 4526.117407105616, 4536.251518499444, 4544.500104988449, 4562.406887104672, 4575.542445755431, 4577.748223847687, 4594.724316541002, 4665.393498845146, 4770.117528257283, 4672.415948006499, 4699.624030077585, 4706.199946009169, 4714.151452738506, 4714.387129673138, 4063.1467391847746, 4104.733192342488, 4247.0, 4274.081072569382, 4286.207051695446, 12660.620181394574, 12843.29361885096, 12882.291473968928, 12938.48246070156, 13275.137116087424, 1884.2839720906104, 1940.088158565472, 1945.8443324534003, 1949.3664559018375, 2080.980319643364, 9286.535673216313, 9640.276979226515, 9659.951700241523, 9688.660896868647, 9811.411315321104, 1568.749000159969, 1608.1959020489755, 1624.0, 1638.8361163883635, 1686.5867862373675, 56455.43544564543, 58487.70756146192, 59438.70280648569, 59826.401735982516, 60049.6997515014, 6483.578567393104, 6624.569402988886, 6742.258351581322, 6755.932440675629, 6777.559458635173, 8057.274845263954, 8069.152738962324, 8079.878801817978, 8089.635966381527, 8125.228103330174, 5326.973365133227, 5328.626996110313, 5341.3857406398765, 5403.8108666196495, 5404.3784964728775, 5331.546818520392, 5340.599455040888, 5349.5720342372515, 5424.213489044067, 5445.237666726662, 3156.2898347871546, 3187.713105820441, 3198.440272952224, 3229.128135403428, 3236.4336241157703, 1118.552578968403, 1120.3110087296418, 1123.9438028098562, 1142.9714257143637, 1174.5477990973366, 415.65915948922196, 421.08834373581465, 423.99788001059795, 464.5540281329961, 481.8265424447196, 9960.551775170135, 10345.12066474343, 10393.168546516412, 10470.528826202839, 10989.175811813986, 434.2834323366408, 441.30274166816355, 447.3401732444618, 457.95878370946775, 465.17895913712323, 5791.131330300404, 5862.0, 5928.081147422156, 5990.311114221833, 6001.669908155006, 494592.0, 500492.0, 503623.0, 512190.0, 518339.0, 74101.62949185328, 76750.6162469184, 77495.0, 77579.2242077572, 77986.0, 470.89404883900846, 474.0424342827469, 476.7163537694997, 476.8068932082512, 478.99281510777365, 9681.0, 9711.611535538499, 9739.951300243454, 9835.16401105914, 9883.11052005323, 31171.220719481287, 31651.20871978219, 31891.173059233042, 32796.508052378755, 32917.0, 46263.768681156376, 46323.53676463327, 47347.0, 47757.52242477531, 47797.283040755116, 6726.091977582963, 6757.0, 6839.6580170990255, 6841.794746157623, 6841.931580684329, 11796.469158888041, 12050.698732531757, 12070.155089144027, 12101.092418068503, 12213.267203967791, 9895.950520247641, 10566.101881340172, 10676.83984740214, 10742.8388574173, 10891.0, 2585.50875333686, 9196.908030919605, 10276.537555810157, 10424.166066714797, 10454.11140053104, 10677.733056673645, 10708.143348532254, 10863.945680271549, 10910.78178436411, 10945.343279403261, 6720.663966801738, 6788.049673045679, 6811.625360605214, 6815.795526134224, 6846.965765171142, 10566.947165264124, 10689.9465502672, 10750.569977200825, 10782.784344312913, 10918.0], "unit": "ms", "name": "jquery.html", "value": 6588.3066565384715}, {"lowerIsBetter": false, "replicates": [1496.543554215964, 1497.0568541818657, 1655.8344165583444, 1775.7513948047267, 1776.333874796952, 7581.469297149201, 7676.270754278348, 7691.115521715004, 7733.690652373905, 7853.175416581248, 7750.573718445483, 7806.414518911076, 7837.255460731236, 7875.409344299186, 7915.881261781078, 2229.398062523122, 2245.494763678176, 2255.8984845681903, 2263.7170353705787, 2266.1841736974675, 2297.8391512594126, 2336.8247381446376, 2338.543983923127, 2340.8010319122895, 2342.26218741096, 2208.282308249817, 2262.7284725832924, 2266.320103968811, 2268.172117177235, 2273.3180045986137, 2186.431527802775, 2256.706628138348, 2279.179495381661, 2280.623697089978, 2281.3498153026308, 2283.7716228377194, 2303.9193628222934, 2318.710161229846, 2325.2094287942014, 2329.2779238436137, 7710.57591832449, 7715.344195743369, 7791.688332466694, 7793.61031948406, 7800.063992320901, 4550.8862278442975, 4603.12540617285, 4623.190941585209, 4641.628669706449, 4654.348391225231, 2924.093531005395, 3001.0996700989617, 3017.4266889290966, 3052.6794686557814, 3055.282008727947, 962.0812124421161, 973.2116985241977, 999.5052449037701, 1002.6891663584239, 1011.3123076308108, 10441.895581044168, 10475.947620261926, 10493.632722854663, 10505.107065899409, 10536.789264214749, 4009.8396064157105, 4058.7564746115327, 4079.347304431277, 4099.077707515785, 4103.056297051695, 8369.707060252862, 8444.324454043663, 8444.324454043663, 8477.957610212034, 8543.40196186261, 4478.39541661878, 4496.505384407713, 4497.955020449819, 4498.077894031716, 4506.549345065468, 4118.402831589463, 4140.0, 4151.543330233671, 4168.353905144708, 4174.5616710245595, 3436.553248077784, 3450.896473105811, 3481.408160612651, 3503.159241781954, 3504.807235602066, 1011.5397494140149, 1036.8341065429495, 1060.0459586372326, 1065.2915810985762, 1065.733566608348, 992.245893121233, 1033.4161198922734, 1068.5351871935734, 1111.7554138089608, 1254.7553227120807, 7033.542819716702, 7063.187733410724, 7078.115235595551, 7109.715611375487, 7141.642917854087, 691.5228492340269, 704.5279662626053, 720.2473415281044, 721.1706537481938, 817.6729308276737, 5588.2455868458055, 5644.74598643062, 5656.377798442168, 5679.77280908759, 5686.488216060575, 8900.599473023729, 9053.456792592466, 9233.584488698025, 9351.766205844771, 9365.391249568756, 9046.86429703555, 9117.0, 9120.771980700403, 9132.497712625736, 9170.633174672937, 7013.509054366145, 7025.648717564203, 7064.258252883476, 7155.141383034069, 7196.172440169343, 6841.486888483284, 6888.345607167311, 6903.413209877016, 6917.654117294216, 6956.513044086865, 7983.441159118806, 8097.190280971856, 8114.188581141839, 8158.673653053811, 8160.714374996846, 8175.264226219669, 8314.0, 8330.458520196167, 8438.873416898628, 8467.068622451403, 6467.967660161858, 6500.414962653194, 6532.771353002622, 6637.70130344126, 6675.499337549606, 7487.625618718933, 7506.9249307506225, 7513.849723005618, 7524.0, 7587.962060189664, 6884.965575172092, 6912.896306555305, 6974.407175389946, 6977.406920411822, 7174.139103307428, 6204.13142160089, 6229.003359462465, 6736.461083113437, 6886.208086070166, 6997.510174287751, 6883.27725588826, 6899.413549848118, 6912.066870972354, 6920.723171073302, 6949.096617439701, 6386.201724784402, 6397.680115994089, 6421.454176395058, 6437.645929473737, 6457.354264573505, 6559.639219842764, 6580.276169621242, 6582.901256481253, 6612.107365505595, 6617.139771829631], "unit": "ms", "name": "mootools.html", "value": 4347.751496424106}, {"lowerIsBetter": false, "replicates": [326.86598494617203, 331.3191391690076, 334.30798247627405, 334.7874099946536, 338.3942742490941, 6220.377962203777, 6271.275399265199, 6290.18227630408, 6330.208723909512, 6361.109444677743, 6058.666773327465, 6158.353372895848, 6230.190075290206, 6236.095766113911, 6270.780522681707, 4775.11660342836, 4819.421669399677, 4821.397325334333, 4824.1316563018645, 4826.806927722887, 4795.592374648159, 4801.90396192076, 4812.855614331575, 4819.614430845541, 4833.105875413043, 4690.742009189493, 4765.28520721891, 4768.856934291976, 4777.928331075019, 4788.233882578771, 4732.408448943865, 4738.47876733559, 4760.690555113941, 4773.0931123086675, 4781.0676918001, 4083.2854250506043, 4182.602652747984, 4183.91632167358, 4185.22573323933, 4222.959469182184, 5919.112133180014, 5949.0, 5963.344032156459, 5981.312149102865, 5984.880302393928, 5585.748641311151, 5600.859978500529, 5602.831915042555, 5604.822987172699, 5612.579056570733, 6512.088307636935, 6598.901016484757, 6633.237177724575, 6640.369164929372, 6645.734170633169, 4617.676762626617, 4656.348111264426, 4664.790084446208, 4671.11248862715, 4675.4155730533685, 6859.0, 6922.0, 6934.237233904267, 6936.79189624307, 6940.271271516469, 4740.601522550855, 4769.618430525549, 4772.832950846704, 4803.519648035169, 4806.158922188673, 4739.857804265877, 4777.784999675023, 4779.402574678165, 4853.296272040534, 4874.098291815954, 5511.311086114236, 5514.61397702157, 5519.69641669712, 5536.557075434036, 5542.445755424425, 6687.331266873273, 6687.498437617198, 6702.430293425114, 6705.329467053256, 6707.5975441473665, 1695.4828777223065, 1714.1429285357322, 1721.3286818140934, 1721.8019927708224, 1724.8706347024024, 1102.9889701103048, 1128.6331942118845, 1129.8474705914596, 1136.2500749505286, 1169.1231576317762, 6430.807075787734, 6459.289478157399, 6481.384268494486, 6484.1246431731115, 6506.804795856037, 6833.658317084126, 6856.382925536725, 6876.0, 6893.20728116273, 6894.069300644349, 6314.715837787218, 6382.170317858741, 6385.393387628168, 6439.774607888701, 6460.806175814733, 3703.9258615001886, 3746.512953316106, 3747.4191500317493, 3750.587435382106, 3754.4743735876455, 7101.325374089453, 7191.352778249878, 7205.279472052857, 7317.414606831547, 7336.559806411526, 7180.497365184387, 7197.0284011658805, 7206.927930720731, 7218.45861560385, 7226.024486694229, 7058.258882817333, 7234.782956511313, 7271.563706177646, 7299.416046716144, 7301.269873012762, 6906.205786334636, 6976.372126508639, 6976.651167441709, 6976.744186046561, 6982.0, 6893.448524117958, 6920.93079069223, 6932.376086152271, 6937.410320122644, 6946.374826265458, 7119.288071192839, 7258.745943891939, 7287.526310789782, 7299.4160467163565, 7314.08573928259, 4613.054323863667, 4669.929951050669, 4681.625469962463, 4683.648726345469, 4687.601553867959, 6877.65611719402, 6932.722691092502, 6951.721931122698, 6960.408365288805, 6970.79087627372, 6614.900776488453, 6730.831729206809, 6765.661716914233, 6769.289224631343, 6778.0, 6713.731450741916, 6728.192616886005, 6732.360425759545, 6758.560693554903, 6763.797086087426, 6585.1439312889015, 6616.768413105518, 6637.767678131242, 6639.236487803964, 6639.966800165968, 6650.235222949423, 6779.694913728796, 6809.965950170217, 6820.693068812015, 6829.0, 6592.571482853599, 6621.172353455818, 6627.834304142242, 6628.105205797348, 6647.6676166192465], "unit": "ms", "name": "prototype.html", "value": 5047.790676171131}, {"lowerIsBetter": false, "replicates": [785.9646315915783, 856.9571521423932, 859.1022381611216, 864.7665130414792, 874.2030711220261, 13503.527376541822, 13586.592402227936, 13586.728265434685, 13637.659058523543, 13798.586042418718, 12877.806832897491, 13548.93225533871, 13594.388252528635, 13631.045826792128, 13635.795463068038, 690.7685925215034, 700.8318003679132, 824.4558591329724, 826.4710585225461, 832.7002279179491, 831.1522247307743, 831.9209675080888, 835.2566216067704, 838.4382463749303, 838.5220424358118, 855.7860534866284, 859.5315553023618, 859.8925134358205, 861.7199410191681, 865.7532603208087, 845.5349557743217, 851.4848516647432, 858.9613467393982, 859.2266959736224, 859.3383095016865, 629.6190804563219, 632.5066448170435, 633.9239291285076, 635.7647670361996, 636.8567072408671, 13609.59171224855, 13742.65643358914, 13748.0, 13754.105983111065, 13758.105723127965, 12434.191777534521, 12466.875331246662, 12555.372231388485, 12573.308468034254, 12582.622521324374, 9391.859122113174, 9474.526273686288, 9477.383970041994, 9504.144626983536, 9571.617135314578, 3645.3073915956147, 3646.2342907989087, 3651.3610118229203, 3652.105234217607, 3661.2677464506937, 47377.28934065992, 47659.0, 48514.27228591574, 48583.27125093126, 48809.0, 9506.287028472892, 9837.0, 9844.507774611384, 9877.209823214125, 9929.950350248348, 12856.29290389019, 12925.676858078623, 12988.675283117998, 12994.0, 12994.155379900276, 6550.240042939313, 6679.332066793282, 6686.7993960181275, 6730.32696730323, 6852.349026842442, 4166.291730405838, 4203.285441474895, 4206.326987681956, 4228.9788551057045, 4240.533541310453, 2794.3572978215125, 2796.6923638399758, 2801.831890086601, 2822.0122956964897, 2827.7737780977473, 459.7976890168315, 462.0504862507512, 462.722366580056, 475.31554561431426, 477.0125839512246, 631.3844002097918, 667.4026746062344, 693.7051753004953, 705.4250785609712, 749.1796482851269, 8959.5968181432, 9393.859092113624, 9619.470929098967, 9729.70810875675, 9731.270154738422, 713.7537549545399, 718.4647437658978, 719.6042176802738, 723.3092396761081, 762.3177256355641, 4045.352743561075, 4056.8782936511952, 4325.653947684178, 4374.168907907488, 4468.575485328888, 56608.0, 57312.42687573071, 57571.42428575744, 57631.71184144053, 57771.422285777444, 50265.0, 51370.74314628403, 51572.48427515677, 51885.740571297654, 51995.220071698954, 46932.7653361731, 47115.057698845834, 47297.290540641916, 48086.51913480891, 48261.276080858814, 8617.224449799549, 8731.73804785832, 8752.51861147643, 8802.943646762173, 8807.119288071142, 34503.827480862434, 34619.0, 34809.47785783266, 35100.0, 35166.0, 40701.59298406978, 40707.59292407156, 41915.1616967665, 44764.552354476036, 45202.54797451983, 8554.700585479479, 8704.173103555153, 8711.085336039625, 8895.73312800617, 9065.95467022687, 12640.876943430414, 12656.74686506283, 12813.359332033175, 12842.35788210567, 13001.089923705249, 11104.777904442028, 11227.607033753779, 11273.7745245093, 11274.943625281821, 11708.121890858049, 11489.195756296978, 11558.422078895854, 11636.825447618123, 12054.337011464453, 12195.451204695988, 10425.530851111567, 10868.293560918515, 11215.271007384494, 11303.491342889754, 11787.646370608896, 9545.570449329658, 9787.706368808947, 9912.385761071142, 9937.155341796028, 9943.900560994298, 9325.30060245498, 9882.654107106217, 10041.096301332915, 10086.394816311045, 10111.39331640104], "unit": "ms", "name": "yui.html", "value": 6221.92287790819}], "name": "dromaeo_css", "value": 6660.7064740977385}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 111.0, 112.0, 112.0, 124.0, 110.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [150.0, 133.0, 154.0, 170.0, 127.0, 148.0, 148.0, 128.0, 164.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 159.0, 161.0, 162.0, 161.0, 161.0, 165.0, 169.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 72.0, 72.0, 148.0, 76.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [92.0, 90.0, 130.0, 90.0, 91.0, 92.0, 130.0, 91.0, 91.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 111.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 148.0, 147.0, 146.0, 148.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 65.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 61.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 86.0, 84.0, 93.0, 85.0, 84.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [134.0, 121.0, 123.0, 120.0, 126.0, 127.0, 119.0, 121.0, 123.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [144.0, 139.0, 149.0, 152.0, 153.0, 165.0, 154.0, 151.0, 150.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 70.0, 70.0, 68.0, 68.0, 70.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1515.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.22340425531914], "unit": "score", "name": "Richards", "value": 212.37683199999995}, {"lowerIsBetter": false, "replicates": [191.8649270913277], "unit": "score", "name": "DeltaBlue", "value": 344.60701600000004}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5055.555555555556], "unit": "score", "name": "Decrypt", "value": 52.65118681318681}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [718.9072609633357], "unit": "score", "name": "Earley", "value": 927.0500329999999}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [594.5303210463734], "unit": "score", "name": "Splay", "value": 137.06786199999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21368.435382223473}]} 15:39:06 INFO - RETURN: dromaeo_css: 6660.71 15:39:06 INFO - RETURN: kraken: 1515.40 15:39:06 INFO - RETURN: v8_7: 21368.44 15:39:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21368.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1515.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6660.71"}}} 15:39:06 INFO - Return code: 0 15:39:06 INFO - # TBPL SUCCESS # 15:39:06 INFO - Running post-action listener: _resource_record_post_action 15:39:06 INFO - Running post-run listener: _resource_record_post_run 15:39:07 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529862656; Read time: 12; Write time: 533052 15:39:07 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 177041408; Read time: 0; Write time: 210100 15:39:07 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 348880896; Read time: 0; Write time: 321840 15:39:07 INFO - Running post-run listener: _upload_blobber_files 15:39:07 INFO - Blob upload gear active. 15:39:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:39:07 INFO - Copying logs to upload dir... 15:39:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.744557 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-18 15:39:07.041877) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:39:07.046182) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009991 build_url: 'https://queue.taskcluster.net/v1/task/9lZYR0OmTyyxtdBqQi7I-w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:39:07.099796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:39:07.100227) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1447884011.334663-1716334625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004773 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:39:07.150770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:39:07.151093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:39:07.151382) ========= ========= Total master_lag: 0.27 =========