builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1448321313.29 results: success (0) buildid: 20151123143007 builduid: a88fdf2437194ae49c327ee4f10d9630 revision: 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.293513) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.294602) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.294902) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006582 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.322001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.322340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.383176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.383532) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.448899) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.449206) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.450071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.450403) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 15:28:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.6M=0s 2015-11-23 15:28:33 (78.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.696535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.696851) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018513 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.750226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:33.750581) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 --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 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 15:28:33,962 truncating revision to first 12 chars 2015-11-23 15:28:33,963 Setting DEBUG logging. 2015-11-23 15:28:33,963 attempt 1/10 2015-11-23 15:28:33,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f6ea7bb1641?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 15:28:34,397 unpacking tar archive at: fx-team-5f6ea7bb1641/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.484976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.485474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.497490) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.498044) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:28:34.498719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-23 15:28:34.499196) ========= /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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:34 INFO - MultiFileLogger online at 20151123 15:28:34 in /builds/slave/test-pgo 15:28:34 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:28:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:28:34 INFO - {'append_to_log': False, 15:28:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:28:34 INFO - 'blob_upload_branch': 'Fx-Team', 15:28:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:28:34 INFO - 'branch': 'Fx-Team', 15:28:34 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:34 INFO - 'config_files': ('talos/linux_config.py',), 15:28:34 INFO - 'default_actions': ('clobber', 15:28:34 INFO - 'read-buildbot-config', 15:28:34 INFO - 'download-and-extract', 15:28:34 INFO - 'populate-webroot', 15:28:34 INFO - 'create-virtualenv', 15:28:34 INFO - 'install', 15:28:34 INFO - 'run-tests'), 15:28:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:34 INFO - 'download_minidump_stackwalk': True, 15:28:34 INFO - 'download_symbols': 'ondemand', 15:28:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:34 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:34 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:34 INFO - 'installer_path': 'installer.exe', 15:28:34 INFO - 'log_level': 'info', 15:28:34 INFO - 'log_name': 'talos', 15:28:34 INFO - 'log_to_console': True, 15:28:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:34 INFO - 'opt_config_files': (), 15:28:34 INFO - 'pip_index': False, 15:28:34 INFO - 'sps_profile': False, 15:28:34 INFO - 'sps_profile_interval': 0, 15:28:34 INFO - 'suite': 'dromaeojs-e10s', 15:28:34 INFO - 'system_bits': '64', 15:28:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:34 INFO - 'title': 'talos-linux64-ix-037', 15:28:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:34 INFO - 'use_talos_json': True, 15:28:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:28:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:34 INFO - 'work_dir': 'build'} 15:28:34 INFO - ##### 15:28:34 INFO - ##### Running clobber step. 15:28:34 INFO - ##### 15:28:34 INFO - Running pre-action listener: _resource_record_pre_action 15:28:34 INFO - Running main action method: clobber 15:28:34 INFO - rmtree: /builds/slave/test-pgo/build 15:28:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:28:35 INFO - Running post-action listener: _resource_record_post_action 15:28:35 INFO - ##### 15:28:35 INFO - ##### Running read-buildbot-config step. 15:28:35 INFO - ##### 15:28:35 INFO - Running pre-action listener: _resource_record_pre_action 15:28:35 INFO - Running main action method: read_buildbot_config 15:28:35 INFO - Using buildbot properties: 15:28:35 INFO - { 15:28:35 INFO - "properties": { 15:28:35 INFO - "buildnumber": 101, 15:28:35 INFO - "product": "firefox", 15:28:35 INFO - "script_repo_revision": "production", 15:28:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:28:35 INFO - "repository": "", 15:28:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:28:35 INFO - "buildid": "20151123143007", 15:28:35 INFO - "slavename": "talos-linux64-ix-037", 15:28:35 INFO - "pgo_build": "True", 15:28:35 INFO - "basedir": "/builds/slave/test-pgo", 15:28:35 INFO - "project": "", 15:28:35 INFO - "platform": "ubuntu64_hw", 15:28:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:28:35 INFO - "slavebuilddir": "test", 15:28:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:28:35 INFO - "branch": "fx-team", 15:28:35 INFO - "repo_path": "integration/fx-team", 15:28:35 INFO - "stage_platform": "linux64-pgo", 15:28:35 INFO - "builduid": "a88fdf2437194ae49c327ee4f10d9630", 15:28:35 INFO - "revision": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3" 15:28:35 INFO - }, 15:28:35 INFO - "sourcestamp": { 15:28:35 INFO - "repository": "", 15:28:35 INFO - "hasPatch": false, 15:28:35 INFO - "project": "", 15:28:35 INFO - "branch": "fx-team-linux64-pgo-talos", 15:28:35 INFO - "changes": [ 15:28:35 INFO - { 15:28:35 INFO - "category": null, 15:28:35 INFO - "files": [ 15:28:35 INFO - { 15:28:35 INFO - "url": null, 15:28:35 INFO - "name": "https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:28:35 INFO - } 15:28:35 INFO - ], 15:28:35 INFO - "repository": "", 15:28:35 INFO - "rev": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3", 15:28:35 INFO - "who": "sendchange", 15:28:35 INFO - "when": 1448321288, 15:28:35 INFO - "number": 6697496, 15:28:35 INFO - "comments": "", 15:28:35 INFO - "project": "", 15:28:35 INFO - "at": "Mon 23 Nov 2015 15:28:08", 15:28:35 INFO - "branch": "fx-team-linux64-pgo-talos", 15:28:35 INFO - "revlink": "", 15:28:35 INFO - "properties": [ 15:28:35 INFO - [ 15:28:35 INFO - "buildid", 15:28:35 INFO - "20151123143007", 15:28:35 INFO - "Change" 15:28:35 INFO - ], 15:28:35 INFO - [ 15:28:35 INFO - "builduid", 15:28:35 INFO - "a88fdf2437194ae49c327ee4f10d9630", 15:28:35 INFO - "Change" 15:28:35 INFO - ], 15:28:35 INFO - [ 15:28:35 INFO - "pgo_build", 15:28:35 INFO - "True", 15:28:35 INFO - "Change" 15:28:35 INFO - ] 15:28:35 INFO - ], 15:28:35 INFO - "revision": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3" 15:28:35 INFO - } 15:28:35 INFO - ], 15:28:35 INFO - "revision": "5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3" 15:28:35 INFO - } 15:28:35 INFO - } 15:28:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:28:35 INFO - Running post-action listener: _resource_record_post_action 15:28:35 INFO - ##### 15:28:35 INFO - ##### Running download-and-extract step. 15:28:35 INFO - ##### 15:28:35 INFO - Running pre-action listener: _resource_record_pre_action 15:28:35 INFO - Running main action method: download_and_extract 15:28:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:28:35 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:28:35 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:28:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json 15:28:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json 15:28:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:28:38 INFO - Downloaded 1302 bytes. 15:28:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:28:38 INFO - Using the following test package requirements: 15:28:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:28:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'jsshell-linux-x86_64.zip'], 15:28:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:28:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:28:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:28:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:28:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:28:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:38 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:28:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:39 INFO - Downloaded 22525834 bytes. 15:28:39 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:28:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:39 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:28:40 INFO - Return code: 0 15:28:40 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:28: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:28:40 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:43 INFO - Downloaded 22525834 bytes. 15:28:43 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:28:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:28:43 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:28:44 INFO - Return code: 0 15:28:44 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:28:44 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:28:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:45 INFO - Downloaded 11130997 bytes. 15:28:45 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:28:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:45 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:28:45 INFO - Return code: 0 15:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:45 INFO - https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:28:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/os3zFskOQOC_UedCE1KJJQ/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:28:47 INFO - Downloaded 57549466 bytes. 15:28:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:47 INFO - mkdir: /builds/slave/test-pgo/properties 15:28:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:28:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:28:47 INFO - Contents: 15:28:47 INFO - build_url:https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:28:47 INFO - Running post-action listener: _resource_record_post_action 15:28:47 INFO - Running post-action listener: set_extra_try_arguments 15:28:47 INFO - ##### 15:28:47 INFO - ##### Running populate-webroot step. 15:28:47 INFO - ##### 15:28:47 INFO - Running pre-action listener: _resource_record_pre_action 15:28:47 INFO - Running main action method: populate_webroot 15:28:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:28:47 INFO - '../fennec_ids.txt'], 15:28:47 INFO - 'tests': ['tcheck2']}, 15:28:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:47 INFO - '--tppagecycles', 15:28:47 INFO - '7'], 15:28:47 INFO - 'tests': ['tsvgm']}}, 15:28:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:28:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:28:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:28:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'tests': ['damp', 'tps']}, 15:28:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['damp', 'tps']}, 15:28:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:28:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:47 INFO - 'other': {'tests': ['a11yr', 15:28:47 INFO - 'ts_paint', 15:28:47 INFO - 'tpaint', 15:28:47 INFO - 'sessionrestore', 15:28:47 INFO - 'sessionrestore_no_auto_restore']}, 15:28:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['a11yr', 15:28:47 INFO - 'ts_paint', 15:28:47 INFO - 'tpaint', 15:28:47 INFO - 'sessionrestore', 15:28:47 INFO - 'sessionrestore_no_auto_restore']}, 15:28:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['a11yr', 15:28:47 INFO - 'ts_paint', 15:28:47 INFO - 'tpaint', 15:28:47 INFO - 'sessionrestore', 15:28:47 INFO - 'sessionrestore_no_auto_restore']}, 15:28:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['a11yr', 15:28:47 INFO - 'ts_paint', 15:28:47 INFO - 'tpaint', 15:28:47 INFO - 'sessionrestore', 15:28:47 INFO - 'sessionrestore_no_auto_restore']}, 15:28:47 INFO - 'other_l64': {'tests': ['a11yr', 15:28:47 INFO - 'ts_paint', 15:28:47 INFO - 'tpaint', 15:28:47 INFO - 'sessionrestore', 15:28:47 INFO - 'sessionrestore_no_auto_restore']}, 15:28:47 INFO - 'other_nol64': {'tests': ['a11yr', 15:28:47 INFO - 'ts_paint', 15:28:47 INFO - 'tpaint', 15:28:47 INFO - 'sessionrestore', 15:28:47 INFO - 'sessionrestore_no_auto_restore']}, 15:28:47 INFO - 'svgr': {'tests': ['tsvgx', 15:28:47 INFO - 'tsvgr_opacity', 15:28:47 INFO - 'tart', 15:28:47 INFO - 'tscrollx', 15:28:47 INFO - 'cart']}, 15:28:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['tsvgx', 15:28:47 INFO - 'tsvgr_opacity', 15:28:47 INFO - 'tart', 15:28:47 INFO - 'tscrollx', 15:28:47 INFO - 'cart']}, 15:28:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'tests': ['tp5o']}, 15:28:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'talos_options': ['--e10s'], 15:28:47 INFO - 'tests': ['tp5o']}, 15:28:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'talos_options': ['--xperf_path', 15:28:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:47 INFO - 'tests': ['tp5n']}, 15:28:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:47 INFO - 'talos_options': ['--e10s', 15:28:47 INFO - '--xperf_path', 15:28:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:47 INFO - 'tests': ['tp5n']}}, 15:28:47 INFO - 'talos.zip': {'path': '', 15:28:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:47 INFO - Running post-action listener: _resource_record_post_action 15:28:47 INFO - ##### 15:28:47 INFO - ##### Running create-virtualenv step. 15:28:47 INFO - ##### 15:28:47 INFO - Running pre-action listener: _resource_record_pre_action 15:28:47 INFO - Running main action method: create_virtualenv 15:28:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:28:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:28:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:28:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:47 INFO - Using real prefix '/usr' 15:28:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:28:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:50 INFO - Installing pip.................done. 15:28:50 INFO - Return code: 0 15:28:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:28:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:28:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:28:50 INFO - Using env: {'DISPLAY': ':0', 15:28:50 INFO - 'HOME': '/home/cltbld', 15:28:50 INFO - 'LANG': 'en_US.UTF-8', 15:28:50 INFO - 'LANGUAGE': 'en_US:en', 15:28:50 INFO - 'LOGNAME': 'cltbld', 15:28:50 INFO - 'MAIL': '/var/mail/cltbld', 15:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:50 INFO - 'MOZ_NO_REMOTE': '1', 15:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:50 INFO - 'NO_EM_RESTART': '1', 15:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:50 INFO - 'SHELL': '/bin/bash', 15:28:50 INFO - 'SHLVL': '1', 15:28:50 INFO - 'TERM': 'linux', 15:28:50 INFO - 'TMOUT': '86400', 15:28:50 INFO - 'USER': 'cltbld', 15:28:50 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:50 INFO - '_': '/tools/buildbot/bin/python'} 15:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:28:50 INFO - Cleaning up... 15:28:50 INFO - Return code: 0 15:28:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:28:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:28:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:28:50 INFO - Using env: {'DISPLAY': ':0', 15:28:50 INFO - 'HOME': '/home/cltbld', 15:28:50 INFO - 'LANG': 'en_US.UTF-8', 15:28:50 INFO - 'LANGUAGE': 'en_US:en', 15:28:50 INFO - 'LOGNAME': 'cltbld', 15:28:50 INFO - 'MAIL': '/var/mail/cltbld', 15:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:50 INFO - 'MOZ_NO_REMOTE': '1', 15:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:50 INFO - 'NO_EM_RESTART': '1', 15:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:50 INFO - 'SHELL': '/bin/bash', 15:28:50 INFO - 'SHLVL': '1', 15:28:50 INFO - 'TERM': 'linux', 15:28:50 INFO - 'TMOUT': '86400', 15:28:50 INFO - 'USER': 'cltbld', 15:28:50 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:50 INFO - '_': '/tools/buildbot/bin/python'} 15:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:50 INFO - Downloading/unpacking psutil>=0.7.1 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:28:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:28:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:52 INFO - Installing collected packages: psutil 15:28:52 INFO - Running setup.py install for psutil 15:28:52 INFO - building 'psutil._psutil_linux' extension 15:28:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:28:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:28:52 INFO - building 'psutil._psutil_posix' extension 15:28:52 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:28:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:28:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:52 INFO - Successfully installed psutil 15:28:52 INFO - Cleaning up... 15:28:52 INFO - Return code: 0 15:28:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:52 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 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:28:52 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:28:52 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:28:52 INFO - Using env: {'DISPLAY': ':0', 15:28:52 INFO - 'HOME': '/home/cltbld', 15:28:52 INFO - 'LANG': 'en_US.UTF-8', 15:28:52 INFO - 'LANGUAGE': 'en_US:en', 15:28:52 INFO - 'LOGNAME': 'cltbld', 15:28:52 INFO - 'MAIL': '/var/mail/cltbld', 15:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:52 INFO - 'MOZ_NO_REMOTE': '1', 15:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:52 INFO - 'NO_EM_RESTART': '1', 15:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:52 INFO - 'SHELL': '/bin/bash', 15:28:52 INFO - 'SHLVL': '1', 15:28:52 INFO - 'TERM': 'linux', 15:28:52 INFO - 'TMOUT': '86400', 15:28:52 INFO - 'USER': 'cltbld', 15:28:52 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:52 INFO - '_': '/tools/buildbot/bin/python'} 15:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:28:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:28:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:54 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:28:54 INFO - Installing collected packages: mozsystemmonitor 15:28:54 INFO - Running setup.py install for mozsystemmonitor 15:28:54 INFO - Successfully installed mozsystemmonitor 15:28:54 INFO - Cleaning up... 15:28:54 INFO - Return code: 0 15:28:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:28:54 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:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:54 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:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:54 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 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:28:54 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:28:54 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:28:54 INFO - Using env: {'DISPLAY': ':0', 15:28:54 INFO - 'HOME': '/home/cltbld', 15:28:54 INFO - 'LANG': 'en_US.UTF-8', 15:28:54 INFO - 'LANGUAGE': 'en_US:en', 15:28:54 INFO - 'LOGNAME': 'cltbld', 15:28:54 INFO - 'MAIL': '/var/mail/cltbld', 15:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:54 INFO - 'MOZ_NO_REMOTE': '1', 15:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:54 INFO - 'NO_EM_RESTART': '1', 15:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:54 INFO - 'SHELL': '/bin/bash', 15:28:54 INFO - 'SHLVL': '1', 15:28:54 INFO - 'TERM': 'linux', 15:28:54 INFO - 'TMOUT': '86400', 15:28:54 INFO - 'USER': 'cltbld', 15:28:54 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:54 INFO - '_': '/tools/buildbot/bin/python'} 15:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:28:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:56 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:28:56 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:28:56 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:28:56 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:28:56 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:28:56 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:28:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:28:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:28:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:57 INFO - Downloading docopt-0.6.1.tar.gz 15:28:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:28:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:57 INFO - Running setup.py install for blobuploader 15:28:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:28:57 INFO - Running setup.py install for requests 15:28:57 INFO - Running setup.py install for docopt 15:28:58 INFO - Successfully installed blobuploader requests docopt 15:28:58 INFO - Cleaning up... 15:28:58 INFO - Return code: 0 15:28:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:28:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:28:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:28:58 INFO - Using env: {'DISPLAY': ':0', 15:28:58 INFO - 'HOME': '/home/cltbld', 15:28:58 INFO - 'LANG': 'en_US.UTF-8', 15:28:58 INFO - 'LANGUAGE': 'en_US:en', 15:28:58 INFO - 'LOGNAME': 'cltbld', 15:28:58 INFO - 'MAIL': '/var/mail/cltbld', 15:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:58 INFO - 'MOZ_NO_REMOTE': '1', 15:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:58 INFO - 'NO_EM_RESTART': '1', 15:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:28:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:28:58 INFO - 'SHELL': '/bin/bash', 15:28:58 INFO - 'SHLVL': '1', 15:28:58 INFO - 'TERM': 'linux', 15:28:58 INFO - 'TMOUT': '86400', 15:28:58 INFO - 'USER': 'cltbld', 15:28:58 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:58 INFO - '_': '/tools/buildbot/bin/python'} 15:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:28:58 INFO - Running setup.py (path:/tmp/pip-HDqa3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:28:58 INFO - Running setup.py (path:/tmp/pip-u5uC6N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:28:58 INFO - Running setup.py (path:/tmp/pip-mS2uyW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:28:58 INFO - Running setup.py (path:/tmp/pip-kUCcZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:28:58 INFO - Running setup.py (path:/tmp/pip-xNs5lJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:28:58 INFO - Running setup.py (path:/tmp/pip-N7u4dH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:28:58 INFO - Running setup.py (path:/tmp/pip-8Rl44C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:28:58 INFO - Running setup.py (path:/tmp/pip-Ti5CbS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:28:58 INFO - Running setup.py (path:/tmp/pip-Aa56G7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:28:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:28:58 INFO - Running setup.py (path:/tmp/pip-mAnO1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:28:59 INFO - Running setup.py (path:/tmp/pip-o6vssD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:28:59 INFO - Running setup.py (path:/tmp/pip-BWOG5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:28:59 INFO - Running setup.py (path:/tmp/pip-aiGcEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:28:59 INFO - Running setup.py (path:/tmp/pip-mtaiki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:28:59 INFO - Running setup.py (path:/tmp/pip-IBN8rx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:28:59 INFO - Running setup.py (path:/tmp/pip-kTgFCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:28:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:28:59 INFO - Running setup.py (path:/tmp/pip-lfifR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:28:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:59 INFO - Running setup.py install for manifestparser 15:28:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:28:59 INFO - Running setup.py install for mozcrash 15:28:59 INFO - Running setup.py install for mozdebug 15:28:59 INFO - Running setup.py install for mozdevice 15:28:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:28:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:28:59 INFO - Running setup.py install for mozfile 15:29:00 INFO - Running setup.py install for mozhttpd 15:29:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for mozinfo 15:29:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for mozInstall 15:29:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for mozleak 15:29:00 INFO - Running setup.py install for mozlog 15:29:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for moznetwork 15:29:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for mozprocess 15:29:00 INFO - Running setup.py install for mozprofile 15:29:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for mozrunner 15:29:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:29:00 INFO - Running setup.py install for mozscreenshot 15:29:01 INFO - Running setup.py install for moztest 15:29:01 INFO - Running setup.py install for mozversion 15:29:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:29:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:01 INFO - Cleaning up... 15:29:01 INFO - Return code: 0 15:29:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:29:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:29:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:29:01 INFO - Using env: {'DISPLAY': ':0', 15:29:01 INFO - 'HOME': '/home/cltbld', 15:29:01 INFO - 'LANG': 'en_US.UTF-8', 15:29:01 INFO - 'LANGUAGE': 'en_US:en', 15:29:01 INFO - 'LOGNAME': 'cltbld', 15:29:01 INFO - 'MAIL': '/var/mail/cltbld', 15:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:01 INFO - 'MOZ_NO_REMOTE': '1', 15:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:01 INFO - 'NO_EM_RESTART': '1', 15:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:01 INFO - 'SHELL': '/bin/bash', 15:29:01 INFO - 'SHLVL': '1', 15:29:01 INFO - 'TERM': 'linux', 15:29:01 INFO - 'TMOUT': '86400', 15:29:01 INFO - 'USER': 'cltbld', 15:29:01 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:01 INFO - '_': '/tools/buildbot/bin/python'} 15:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:29:01 INFO - Running setup.py (path:/tmp/pip-i9YggO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:29:01 INFO - Running setup.py (path:/tmp/pip-WR1y1w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:29:01 INFO - Running setup.py (path:/tmp/pip-J30ADO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:29:01 INFO - Running setup.py (path:/tmp/pip-jxQWvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:29:01 INFO - Running setup.py (path:/tmp/pip-RMnMbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:29:01 INFO - Running setup.py (path:/tmp/pip-oDrqU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:29:01 INFO - Running setup.py (path:/tmp/pip-XdOq1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:29:02 INFO - Running setup.py (path:/tmp/pip-nbzcw5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:29:02 INFO - Running setup.py (path:/tmp/pip-CnORYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:29:02 INFO - Running setup.py (path:/tmp/pip-Wdl7R7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:29:02 INFO - Running setup.py (path:/tmp/pip-Uva2iL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:29:02 INFO - Running setup.py (path:/tmp/pip-DR0WmX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:29:02 INFO - Running setup.py (path:/tmp/pip-w6mpVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:29:02 INFO - Running setup.py (path:/tmp/pip-rf3P7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:29:02 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:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:29:02 INFO - Running setup.py (path:/tmp/pip-8iYLlN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:29:02 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:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:29:02 INFO - Running setup.py (path:/tmp/pip-lIimpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:29:02 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:29:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:29:02 INFO - Running setup.py (path:/tmp/pip-hKnbh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:29:02 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:29:02 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:29:02 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:29:02 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:29:02 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:29:02 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:29:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:04 INFO - Downloading blessings-1.5.1.tar.gz 15:29:04 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:29:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:04 INFO - Installing collected packages: blessings 15:29:04 INFO - Running setup.py install for blessings 15:29:04 INFO - Successfully installed blessings 15:29:04 INFO - Cleaning up... 15:29:04 INFO - Return code: 0 15:29:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:29:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:29:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:29:04 INFO - Reading from file tmpfile_stdout 15:29:04 INFO - Current package versions: 15:29:04 INFO - argparse == 1.2.1 15:29:04 INFO - blessings == 1.5.1 15:29:04 INFO - blobuploader == 1.2.4 15:29:04 INFO - docopt == 0.6.1 15:29:04 INFO - manifestparser == 1.1 15:29:04 INFO - mozInstall == 1.12 15:29:04 INFO - mozcrash == 0.16 15:29:04 INFO - mozdebug == 0.1 15:29:04 INFO - mozdevice == 0.47 15:29:04 INFO - mozfile == 1.2 15:29:04 INFO - mozhttpd == 0.7 15:29:04 INFO - mozinfo == 0.9 15:29:04 INFO - mozleak == 0.1 15:29:04 INFO - mozlog == 3.1 15:29:04 INFO - moznetwork == 0.27 15:29:04 INFO - mozprocess == 0.22 15:29:04 INFO - mozprofile == 0.27 15:29:04 INFO - mozrunner == 6.11 15:29:04 INFO - mozscreenshot == 0.1 15:29:04 INFO - mozsystemmonitor == 0.0 15:29:04 INFO - moztest == 0.7 15:29:04 INFO - mozversion == 1.4 15:29:04 INFO - psutil == 3.1.1 15:29:04 INFO - requests == 1.2.3 15:29:04 INFO - wsgiref == 0.1.2 15:29:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:04 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 0x7f826e8dfc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', '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:29:04 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:29:04 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:29:04 INFO - Using env: {'DISPLAY': ':0', 15:29:04 INFO - 'HOME': '/home/cltbld', 15:29:04 INFO - 'LANG': 'en_US.UTF-8', 15:29:04 INFO - 'LANGUAGE': 'en_US:en', 15:29:04 INFO - 'LOGNAME': 'cltbld', 15:29:04 INFO - 'MAIL': '/var/mail/cltbld', 15:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:04 INFO - 'MOZ_NO_REMOTE': '1', 15:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:04 INFO - 'NO_EM_RESTART': '1', 15:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:04 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:04 INFO - 'SHELL': '/bin/bash', 15:29:04 INFO - 'SHLVL': '1', 15:29:04 INFO - 'TERM': 'linux', 15:29:04 INFO - 'TMOUT': '86400', 15:29:04 INFO - 'USER': 'cltbld', 15:29:04 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:04 INFO - '_': '/tools/buildbot/bin/python'} 15:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:29:05 INFO - Cleaning up... 15:29:05 INFO - Return code: 0 15:29:05 INFO - Running post-action listener: _resource_record_post_action 15:29:05 INFO - Running post-action listener: _start_resource_monitoring 15:29:05 INFO - Starting resource monitoring. 15:29:05 INFO - ##### 15:29:05 INFO - ##### Running install step. 15:29:05 INFO - ##### 15:29:05 INFO - Running pre-action listener: _resource_record_pre_action 15:29:05 INFO - Running main action method: install 15:29:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:29:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:29:05 INFO - Reading from file tmpfile_stdout 15:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:29:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:29:05 INFO - Reading from file tmpfile_stdout 15:29:05 INFO - Output received: 15:29:05 INFO - Usage: mozinstall [options] installer 15:29:05 INFO - Options: 15:29:05 INFO - -h, --help show this help message and exit 15:29:05 INFO - -d DEST, --destination=DEST 15:29:05 INFO - Directory to install application into. [default: 15:29:05 INFO - "/builds/slave/test-pgo"] 15:29:05 INFO - --app=APP Application being installed. [default: firefox] 15:29:05 INFO - mkdir: /builds/slave/test-pgo/build/application 15:29:05 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:29:05 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:29:19 INFO - Reading from file tmpfile_stdout 15:29:19 INFO - Output received: 15:29:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:29:19 INFO - Running post-action listener: _resource_record_post_action 15:29:19 INFO - ##### 15:29:19 INFO - ##### Running run-tests step. 15:29:19 INFO - ##### 15:29:19 INFO - Running pre-action listener: _resource_record_pre_action 15:29:19 INFO - Running main action method: run_tests 15:29:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:29:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:29:19 INFO - Python 2.7.3 15:29:19 INFO - Return code: 0 15:29:19 INFO - grabbing minidump binary from tooltool 15:29: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:29:19 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 0x1a62d70>, '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 0x1a63b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a63fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:29:19 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:29:19 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:29:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:19 INFO - Return code: 0 15:29:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:29:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:29:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:29:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:29:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:29:19 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/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:29:19 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/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 15:29:19 INFO - Using env: {'DISPLAY': ':0', 15:29:19 INFO - 'HOME': '/home/cltbld', 15:29:19 INFO - 'LANG': 'en_US.UTF-8', 15:29:19 INFO - 'LANGUAGE': 'en_US:en', 15:29:19 INFO - 'LOGNAME': 'cltbld', 15:29:19 INFO - 'MAIL': '/var/mail/cltbld', 15:29:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:29:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:19 INFO - 'MOZ_NO_REMOTE': '1', 15:29:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:19 INFO - 'NO_EM_RESTART': '1', 15:29:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:29:19 INFO - 'PWD': '/builds/slave/test-pgo', 15:29:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:29:19 INFO - 'SHELL': '/bin/bash', 15:29:19 INFO - 'SHLVL': '1', 15:29:19 INFO - 'TERM': 'linux', 15:29:19 INFO - 'TMOUT': '86400', 15:29:19 INFO - 'USER': 'cltbld', 15:29:19 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172', 15:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:19 INFO - '_': '/tools/buildbot/bin/python'} 15:29:19 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/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 15:29:20 INFO - mozversion INFO | application_buildid: 20151123143007 15:29:20 INFO - mozversion INFO | application_changeset: 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 15:29:20 INFO - mozversion INFO | application_display_name: Nightly 15:29:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:20 INFO - mozversion INFO | application_name: Firefox 15:29:20 INFO - mozversion INFO | application_remotingname: firefox 15:29:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:29:20 INFO - mozversion INFO | application_vendor: Mozilla 15:29:20 INFO - mozversion INFO | application_version: 45.0a1 15:29:20 INFO - mozversion INFO | platform_buildid: 20151123143007 15:29:20 INFO - mozversion INFO | platform_changeset: 5f6ea7bb1641c89b4545f7b68f2378b2c172c7e3 15:29:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:29:20 INFO - mozversion INFO | platform_version: 45.0a1 15:29:20 INFO - 2015-11-23 15:29:20,101 DEBUG : using testdate: 1448321360 15:29:20 INFO - 2015-11-23 15:29:20,101 DEBUG : actual date: 1448321360 15:29:20 INFO - 2015-11-23 15:29:20,110 INFO : starting webserver on 'localhost:37490' 15:29:20 INFO - 2015-11-23 15:29:20,110 INFO : Starting test suite talos-linux64-ix-037.e 15:29:20 INFO - 2015-11-23 15:29:20,110 INFO : Starting test dromaeo_css 15:29:20 INFO - 2015-11-23 15:29:20,110 DEBUG : operating with platform_type : linux_ 15:29:20 INFO - 2015-11-23 15:29:20,111 INFO : Initialising browser for dromaeo_css test... 15:29:20 INFO - 2015-11-23 15:29:20,118 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphUpPE_/profile http://localhost:37490/getInfo.html 15:29:25 INFO - 2015-11-23 15:29:25,516 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:29:25 INFO - 2015-11-23 15:29:25,516 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:29:25 INFO - 2015-11-23 15:29:25,516 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:29:25 INFO - 2015-11-23 15:29:25,516 DEBUG : BROWSER_OUTPUT: __metrics 15:29:26 INFO - 2015-11-23 15:29:26,581 INFO : Browser initialized. 15:29:26 INFO - 2015-11-23 15:29:26,582 INFO : Running cycle 1/1 for dromaeo_css test... 15:29:26 INFO - 2015-11-23 15:29:26,582 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphUpPE_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:29:38 INFO - 2015-11-23 15:29:38,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 139325440 15:29:38 INFO - 2015-11-23 15:29:38,396 DEBUG : BROWSER_OUTPUT: 15:30:28 INFO - 2015-11-23 15:30:28,019 DEBUG : BROWSER_OUTPUT: 1448321428015 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:32:37 INFO - 2015-11-23 15:32:37,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37490/tests/dromaeo/cssquery-ext.html) 15:32:38 INFO - 2015-11-23 15:32:38,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 146497536 15:32:38 INFO - 2015-11-23 15:32:38,057 DEBUG : BROWSER_OUTPUT: 15:35:40 INFO - 2015-11-23 15:35:40,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-ext.html (next: http://localhost:37490/tests/dromaeo/cssquery-jquery.html) 15:35:40 INFO - 2015-11-23 15:35:40,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 140685312 15:35:40 INFO - 2015-11-23 15:35:40,638 DEBUG : BROWSER_OUTPUT: 15:38:42 INFO - 2015-11-23 15:38:42,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37490/tests/dromaeo/cssquery-mootools.html) 15:38:42 INFO - 2015-11-23 15:38:42,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 15:38:42 INFO - 2015-11-23 15:38:42,875 DEBUG : BROWSER_OUTPUT: 15:41:44 INFO - 2015-11-23 15:41:44,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37490/tests/dromaeo/cssquery-prototype.html) 15:41:45 INFO - 2015-11-23 15:41:45,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 140177408 15:41:45 INFO - 2015-11-23 15:41:45,091 DEBUG : BROWSER_OUTPUT: 15:44:47 INFO - 2015-11-23 15:44:47,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37490/tests/dromaeo/cssquery-yui.html) 15:44:48 INFO - 2015-11-23 15:44:48,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 142655488 15:44:48 INFO - 2015-11-23 15:44:48,036 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/dromaeo/cssquery-yui.html (next: http://localhost:37490/tests/dromaeo/cssquery-dojo.html) 15:47:50 INFO - 2015-11-23 15:47:50,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 144273408 15:47:50 INFO - 2015-11-23 15:47:50,653 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,653 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:47:50 INFO - 2015-11-23 15:47:50,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:47:50 INFO - 2015-11-23 15:47:50,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:47:50 INFO - 2015-11-23 15:47:50,653 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:47:50 INFO - 2015-11-23 15:47:50,656 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3245;3263.5104734289866;3303.141183292343;3304.322613864158;3317.8672853085877;5265.18389649604;5318.707471089088;5364.463553644634;5402.6758394496355;5415.837524874255;5296.761645725942;5374.435684253156;5442.346918369801;5495.670259784406;5503.091989821674;4742.217534106868;4967.205247160446;5189.351331083614;5196.818111366103;5212.400573933989;4872.731999740013;5137.922931156036;5149.382074151088;5162.303089082963;5194.142966410556;4950.900981980359;5008.198688209887;5062.797488100471;5066.392032956069;5091.821786237501;5026.070177017264;5033.043721692903;5035.899282014339;5075.6447048706605;5087.771050302746;4868.829590964299;4950.405951285833;5019.171836646985;5031.295618613397;5040.42035165957;5168.3539557555305;5197.740112994373;5223.37319521656;5233.371995360543;5288.233206185082;5811.941880581182;5812.854678633025;5816.912746308809;5820.272465941757;5890.705464726747;5667.064934285879;5757.222774925373;5790.189373487715;5857.502112320458;5870.911936320958;5577.9959607270675;5580.804671836548;5594.412586678422;5596.916046259309;5610.270664813589;5985.40145985398;6025.638461692312;6041.275046994301;6044.486218671462;6044.727987240584;5668.0647693130995;5771.509421699118;5841.153032810219;5855.765769369263;5897.587168898136;5956.851078723066;5963.0459126539545;5970.76116955317;5973.223480947449;5979.222701048836;5897.498712609477;5929.377415371324;5934.406559344117;5959.404059594092;5980.641161530322;5673.602847800615;5810.709464526842;5842.766289348463;5908.675022873697;5955.67243801595;4438.090191510797;4477.552244775561;4484.1255955088445;4507.639388848885;4574.611158051536;3931.7837518936735;4044.5348784889525;4045.4538637284177;4067.6745860331694;4079.204555111725;5419.6477228980775;5421.83734487966;5438.021156191844;5453.618246722771;5515;5902.4097590240635;5920.733566989496;5921.792737254262;5924.585279030426;5926.140709597084;5292.179712144623;5394.703291318937;5503.147012213113;5518.365387980353;5519.31008623922;5123.897522049539;5176.430592634807;5197.454267301954;5216.713080780593;5253.789848406021;6122;6127.84680382994;6131.540134489931;6142.723577439026;6146.170267013986;5729;5833.883322333614;5881.5000724937145;5950.34546199909;5961.195238642727;6138.81758342749;6144.938550614436;6156.722947467285;6177.938220617736;6183.721732522137;5846.327672317738;5861.062230043172;5917.940820591911;5918.579540910065;5929.110633405024;5718.25662663851;5773.364929857797;5850.94149058504;5859.179714839841;6015.097735339734;5752.050911599539;5758.280214973129;5773.797917072882;5775.306963164448;5777.653340799566;5749.913751293818;5753.741081651419;5761.078227483583;5763.423657634203;5775.971120144372;5510.944890551204;5614.522765564972;5654.208410822571;5752.453516915886;5797.884042319046;5720.11338242573;5781.537477001913;5846.824595262149;5854.736536855937;5858.091995740667;5472.26124473207;5651.971740141273;5725.51333136688;5739.368669446274;5754.971225144015 15:47:50 INFO - 2015-11-23 15:47:50,657 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.2236728979426;574.4628772098091;579.1284117403309;590.1649166429503;603;38336.616633833655;38726.8063659682;38939.610603893954;39060.80469597655;39063;42461;42964;43077.35383969243;43167.568324316744;43298.56701432985;8779.69271075511;8879.556022198896;8909.509976951265;8918.598663060146;8959.462432254053;8662.480251184918;8692.087330830267;8751.168638979287;8756.60595273211;8777.034526202113;8681;8757.95621021894;8765.298776097898;8802.559872006406;8811.64753409866;8704.869426958601;8710;8770.473771573726;8771.12288771124;8779.95610021949;8615.267702245317;8675;8743.213110820057;8744.956275218647;8778.824423511558;39270.60729392726;39385.60614393877;39440.60559394398;39483.8025809872;39840.20319593621;3430.588329400463;3447.293304872495;3639.508666330038;3918.960810391888;3937.606239376068;29047.70952290471;29479.263018424495;29889;30592.388152237054;30790.38419231625;3817.408301713239;3820.2550502651993;3880.2821478026653;3907.081835768592;3924.666403355718;267491;268528;268974.6551267251;269848;269923;53831.19253211205;55124;56602.43397566054;56757.432425675215;56898.14652780211;66138.33861661419;66795;66912.33087669159;67106;67115.66442167855;15422.537323880302;15576.922115389578;15642.765358519631;15667.529974100795;15670.608234793994;11830.704232394259;12029.954907665719;12051.57819476314;12052.096092793076;12091.697707557381;19106.904465477583;19325.13036913314;19432.902835485733;19437.902810485855;19470.70793938092;7644.120926093459;7693.846123077619;7737.767866964;7772.65023073963;7779.533228006338;911.4258017448965;942.7171848445576;986.225812736998;990.980180396388;1068.8396740488988;28078.578821317697;28230.71769282322;28435.28911777181;28483.857580711963;28589.285267868054;1043.879953805307;1072.651388298806;1097.4183682648209;1145.473082382097;1178.1517307538559;14696.853031469549;14786.63033424173;14805.703885922221;14910.105393676415;14915.328810203568;306584;312436;312814;312916;313065;50799;50884.236736448984;51207;51267.743661281456;51327.743361282955;1320.42561485754;1330.6673331667084;1331.5472739268696;1333.1001573937554;1333.3333333333333;26967.595486067334;27523.31191720143;27880.58179127355;28100.859495702392;28204.294892627848;44629.330560042275;44784.552154478035;44883.77558112189;44913.77543112264;45037.77481112573;302046;302120;302157;302287;302634;29414.852925735235;31531;31702.207444814063;31757.20606984844;31800.681993179773;37409.81295093507;38224.42663360108;38420.6157938417;38618.42072368861;38931;32895.342093157524;35259.29481410409;35885.28229435344;36079.81960090183;36374.09064773402;34745.30509389849;34862.12844678904;35124.297514050086;35613.64386356103;35694.28611427705;34285.31429371348;34542.48186277258;34699.47950780791;34907.30185396227;35090.473642895886;31371;31864.840675796473;32166.51750223795;32290.677093228765;32413.35173296568;24703.62944555797;24703.62944555869;24782.504349913263;25257;25329.366765830266 15:47:50 INFO - 2015-11-23 15:47:50,658 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.33925559204295;354.8491890946349;355.55555555555554;359.4410691374912;359.9352116619009;14038.719225615481;14108.506202282922;16495;17002.659946801057;17692.38076667315;14545.200013999225;16770.66458670826;16959.558437532793;17321.82678173218;17376.82623173768;5294.841154765353;5443.564514838803;5451.781928722847;5454.972725136368;5455.781768729246;5273.288106105665;5405.702686352249;5443.972780136113;5456.781728730846;5468.398476167618;5350.625456218067;5374.7850085996515;5400.351957765074;5422.593305502083;5424.105022671254;5428.647137936041;5432.674039557639;5435.673859568419;5437.809676661298;5458;5176.534111929906;5196.350456192976;5227.424983251839;5237.973810130963;5247.895042099137;18965;19094.23623055076;19551.315703950437;19607.117679704304;19614.215431382727;2022.1810166882435;2087.8538502304846;2104.1793700456833;2119.162930642403;2119.4336219695692;9097.681581144629;9141.360104792668;9234.307426943005;11501;12011.858873407013;1836.2012524551862;1840.8987505687182;1847.4827048426462;1882.8587855910725;1904.8094940662086;60135.69932150311;61441;61800.69099654518;62570;64440.677796611184;9906.108450239513;10031.197504199647;10104.949475252724;10147.34042287249;10165.440900750382;12763.872361276453;12776.552820651232;12832.165909215872;12845;12883.227006379648;7704.8844267336035;7795.766127016199;7803.609819509002;7818.687252509836;7877.921220787834;7773.378129749606;7801;7814.179511151361;7824.882626760603;7849.529028258323;4262.808173632194;4286.571342865688;4344.45694288214;4353.891152721208;4393.890152746143;1743.1632816248273;1797.1014492753623;1808.6563552925165;1836.3113832312883;1837.4855040588657;886.7029545102334;938.558877327655;1006.4112494190834;1008.4302369161401;1011.9779023186487;15757.921210393875;15855.841441585668;15956.920215399081;16326.020438773712;16377.67244655124;940.9837375634298;941.2799208605422;944.6268723854039;955.4124213608719;959;9646.951765241129;9649.710508684751;9683.90316096844;9757.219422446187;9759.512024398893;474962;481012;484352;496241;499338;77192.61403692946;80985.59507202545;81730;81733.59133204295;82133;1113.5935383584933;1117.212365282474;1126.132877684195;1133.0482394788417;1141.2353723005606;14841.925790371411;14927;15002.249887505362;15094.320755566245;15301.387944482096;32693;32963.835180823946;33589;33614.83192584021;34645.307093857475;44871;46267;47726.76136619295;47953.520464796304;48195.5180448191;9037.50293733851;9249.260059195114;9379.296552758708;9425.151736343762;9578.521073946136;10798.082163015917;10803.675889723007;16126.67746645084;17025;17506.387276445264;14583.489577864724;14866.405343786128;14938.701225975637;15167.938244322791;15246.695066098395;14344;14462.20457874827;14919.403223870924;15050.096994180385;15263.08421494714;15129;15227.390904363701;15357.462488812838;15373.1544765039;15656.608584785472;9272.675456358995;9591.328606997722;9645.469499177612;9650.324477286804;9709.951450242703;14734;14824.555263342118;14939.592820118309;14951.177685227416;15248.542543723706 15:47:50 INFO - 2015-11-23 15:47:50,659 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1519.043002908169;1677.9077150756707;1762.277466238842;1764.541219282986;1800.3698705453094;7249.782506524806;7350.117985841706;7594.506357086785;7629.275218854207;7666.923330766691;7728.92271077289;7797.883031754528;7836.13802481728;7861.960690196555;7862.803429914255;2253.6619507073947;2282.0643536150183;2284.4403121235237;2284.885755712216;2286.542691461706;2244.921427750029;2268.8184945204425;2297.448612333036;2299.1608063056947;2302.9078836846506;2133.797289257526;2209.7016902718087;2214.568159208955;2273.7385200701965;2287.874166920819;2129.659254519285;2154.450615093149;2189.37602783206;2200.1749343996003;2200.1969281212323;2271.5002699406105;2311.7457079721216;2312.953740925189;2316.293530473205;2316.872572008539;7410.925890741078;7484.663190156456;7490.812729681802;7499.662515186775;7511.436642251853;4640.118377508263;4761.666683332168;4779.163646361872;4783.043391321749;4786.1863483207935;2974.9553756693667;3027.137265879214;3060.1737530866762;3085.305806193611;3102.5811515445575;955.2501286490142;965.5124162297994;1005.8390657494839;1008.3848852200152;1010.3382284603597;10205.336653117523;10221;10337.328073675262;10343.534540945675;10349.379037257864;4073.51117865858;4086.7139300248696;4176.14389050244;4206.095689426788;4219.092895027584;8460.661573537112;8493.405461617627;8497.192766687154;8510.319174466027;8561.614727337284;4616.884577885579;4620.67655264135;4641.071785642885;4670.859874203779;4689.60138388234;4254.042840360956;4256.5105012923295;4287.292596721569;4300.634446072057;4308.482982042175;3472.0972547137926;3484.756067075331;3523.3834079036064;3536.734744894143;3543.6987856032524;1076.7469644633504;1080.6541906589816;1094.9124070074374;1094.950727217277;1105.5909313554037;1042.7028296935337;1045.0959919669583;1105.9557617695364;1219.9817002744967;1366.5285476510587;6492;6500.967495162494;6504.414602685781;6530;6620.768273110418;1124.128800179867;1124.2804605052772;1137.8122609769296;1142.1719253541116;1149.5057125435976;5683.54531637468;5704.058830293038;5708.543316534668;5720.08478643415;5745.511631511368;8785.516796576121;8820.382573219813;8969.327300452493;9034.277257819358;9059.184673379295;8855.070217627057;8856.690015849414;8862.335324850534;8867.822643547093;8885.42244754089;6866.828329291708;6869.9999999999;6962.651867406609;7017.087778588751;7110.395616372666;6927.238003819677;6956.2000369958105;6965.303469652994;6980.895286570807;6999.545029573062;7855.253750893656;8091.514509129471;8114.715984940499;8121.878171827546;8140.75577732669;8132.308753755997;8291.875621865798;8325.583720814057;8352.749417517483;8466.74599762008;6494.74021039172;6496.447801936888;6504.804855854332;6667.49993750461;6702.36327548882;7294.015307933361;7359.668814903235;7397.667104980181;7403.8149046274275;7433.591152486449;6114.510839132769;6836.589804611739;7085.326893945067;7105.75129870452;7232.059832221988;6926.238113807376;6956.79129626112;6958.652067396509;7028.543144695578;7062.39969602569;6419.903701444576;6635.369639884203;6656.334366563305;6676;6699.832504187434;6417.326180750954;6426.646534440651;6437.195350581177;6446.64543450096;6458.67706614658;6484.1246431733;6542.182227221598;6580;6591.967040164768;6615.536912416084 15:47:50 INFO - 2015-11-23 15:47:50,660 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.70577453705084;334.66199138869734;336.9595648522178;338.91018879996807;341.332694582092;6389;6418;6442.065900444439;6501.382368674968;6598.703058362374;6373.776917807878;6411.487081033518;6411.551191416591;6438.066480360345;6441.967790161054;4815.879603009936;4819.759012049383;4822.324874517571;4825.831095911643;4827.082854257697;4817.470078291385;4819.734914579697;4822.951770482303;4828.106800241949;4828.396450443694;4581.748003859786;4757.26262429324;4762.666613337068;4765.642576806753;4776.641751868607;4718.905621887578;4731;4748.240281554952;4753.287006948951;4755.809767609291;4070.1656160487323;4075.9388609170887;4081.244969680589;4083.959160408417;4089.0595163112653;6047.7580896764075;6050.122732203806;6074.908876366858;6078.75684972605;6080.270367555878;5454.53636440903;5490.780368785244;5508;5534.695591742453;5547.77808887644;6684.398404143651;6705.564138330993;6727.394534491919;6742.595444273359;6743.93256067438;4516.412866327357;4527.501974782771;4555.589996900262;4566.520515345874;4569.451665800092;6871;6959.826004349881;7014.438844892396;7015.123109611299;7036.648167591651;4619.95380046202;4631.444226692818;4633.791479383436;4637.698549594265;4641.883952901205;4701.905961880743;4708.246680531099;4709.882252943704;4712.410948631421;4713.858584242478;5486.506214440719;5503.3120859892515;5511.669299842022;5512.724363781795;5517.420670829585;6579.342065793382;6761.4590832733265;6811.761588344483;6820.31796820314;6856.108705868305;1599.6000999750063;1643.6137507685685;1664.167916041979;1665.267282395742;1666.500049985024;1069.556134204312;1070.0209308482806;1080.6974047266779;1089.3681664634494;1092.502911175429;6312;6369.20384951881;6399.680015999182;6405.263394709668;6418.8716225675225;6912.516123871382;6922.757703480354;6933.37599616037;6940.236573976858;6963.234044255128;6336.651484168415;6354.17395738551;6370.872582548323;6384.936150638527;6394.84012899672;3827.6363745444137;3853.788041657736;3873.32216862048;3892.9805350973065;3898.8440462381755;7345.375643070292;7362.300581444754;7370.557766534025;7372.189059203483;7393.667284972189;7080.92919070813;7229.7469588564145;7300.050993370828;7304.342609165201;7313.524620899624;7318.96340518294;7356.852862942711;7386.667599958015;7388.815279617945;7389.889151662622;7089.539179953286;7104.254053324326;7112.217656057726;7121.287871212838;7124.323189297009;6877.552959057645;6978.79063628092;7019;7021.719131234898;7036.085308909809;7289.562626242442;7350.96324518374;7360.852782944204;7379.9262007381385;7380.44646651514;4627.5603817637275;4656.674032817806;4662.813487460464;4668.229742092517;4677.111348843709;6913.343232392915;6954.617496037767;7079.22128565847;7085.256048114874;7087.255838136922;6784.050232967487;6787.287334829772;6804.795856124324;6816.727330906709;6823.317668233137;6817.5909445433435;6839.555428897106;6850.554713943578;6856.457297108111;6877.2091209509545;6525.64108973992;6759.932400675931;6764.93235067643;6769.661516924232;6775.966120169368;6886.621235832077;6912.4815638828295;6924.4460443165435;6927.930720692729;6935.202451718117;6746.595204287562;6753.223379311442;6755.1556055493065;6760.661966901734;6764.932350676627 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: |5;yui.html;721.5093736259345;735.5366119344814;735.6285076036601;738.6085374751381;833.8290650416665;13671.111377760439;14008.159510429356;14023.579292621213;14070.663286987745;14071.155730656168;12979.805302920464;14570.125792452434;14585.562433127023;14673.633159171026;14709.92645036776;813.6501304439089;818.868980963046;828.2918105020211;831.3100126894693;835.6490274084869;817.7424111404888;821.876718492225;822.2229992656942;822.391430341546;822.4900561651755;863.7883718488979;866.7919699272161;867.0202670981781;868.6047848229073;869.652139144341;865.3596338709341;868.700298397052;868.9261412779858;876.5135349880813;882.3029806452895;638.5306799502362;638.9041643753428;639.9136116624243;642.1555654314561;644.3620815392775;14084;14263.85736142646;14326.856731432656;14353.282335883268;14362.784558231635;11888.108391870644;11901.761964760657;11924.284542927453;12199.268043917393;12253.081018923616;10226.386416815016;10358.119559837423;10627.84058239127;10693;10731.678049658523;3633.7819730816236;3636.5817930938015;3640.7087433005295;3670.5228320318456;3780.3384407728536;44583;44738.99999999967;45176.09647807058;45219.54780452186;45327.77336113298;9530.428174309563;9548.61805527785;9579.616815327308;9735.221182305399;9953;17669.20488578017;17709.114544272736;17770.289188432318;17772.111394430227;17774.555636109202;6896.3103689631635;6992.2658120897595;7157.6779044943105;7160.749373771893;7384.889226661604;4162.958370416257;4219.346001369792;4256.34026725858;4260.5952434519295;4290.163418133497;2971.1235185620294;2975.598294230251;2984.6567644721135;2985.0746268656353;2994.5807586937844;546.573672535423;562.3701454371048;565.8104534980745;566.5863919338823;568.8720037991419;559.426587747562;576.0984059946254;578.8668606220593;580.231193668391;587.2662754875973;7388;7508.587027713419;7762.7671169865;7769.689212431553;7790.182030886675;570.1760955419462;574.2362657665295;583.2446981159324;598.4374687793547;605.2132228103447;3623.3477973964414;3711.4247291669294;3863.4977452931503;3987.142764305688;4026.859059932888;51399;51635.48364516307;57663.67522435834;58195;58632.12051819226;53693.73153134288;53976.73011634995;54043.18935215975;57620.42379576234;57635.42364576385;50346.496535034916;50792.238116428285;51351.743241283555;53180.46819531755;53853.192202117;7571.167171611009;7730.18833022547;7859.882101768364;7876;8096;33497.16257093495;33636.49545256774;34290.314193716484;34935;35088.47367289544;43389;44161;45059.77470112628;45338.546614533436;45748.771256144835;10810.783784324427;10831.837522437327;10916.890831091587;11015.394153321644;11441;11025.889741102486;11220.719482013015;11269.605563805228;11283.040941520063;11662.241954272946;10568;10721.463926803473;10882.075023623082;11145.415405113967;11440.48517816717;10920;11067.72330691739;11100.777984440427;11165.16261280391;11553.729089800283;10293.176545876162;10544.683659490227;10761.838572421577;10795.514201861091;11074.11407087415;9279.39683920543;9346.672866449642;9377.953110234404;9397.718068457958;9630.951845240728;8425.410221284452;8636.27274545081;8645.438046526955;9051.14014168653;9306.441613503212 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,312 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322470652__endTimestamp 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,661 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5467.58 Median:5673.60 stddev:610.59 (10.8%) stddev-sans-first:587.04 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: Values: 3245.0 3263.5 3303.1 3304.3 3317.9 5265.2 5318.7 5364.5 5402.7 5415.8 5296.8 5374.4 5442.3 5495.7 5503.1 4742.2 4967.2 5189.4 5196.8 5212.4 4872.7 5137.9 5149.4 5162.3 5194.1 4950.9 5008.2 5062.8 5066.4 5091.8 5026.1 5033.0 5035.9 5075.6 5087.8 4868.8 4950.4 5019.2 5031.3 5040.4 5168.4 5197.7 5223.4 5233.4 5288.2 5811.9 5812.9 5816.9 5820.3 5890.7 5667.1 5757.2 5790.2 5857.5 5870.9 5578.0 5580.8 5594.4 5596.9 5610.3 5985.4 6025.6 6041.3 6044.5 6044.7 5668.1 5771.5 5841.2 5855.8 5897.6 5956.9 5963.0 5970.8 5973.2 5979.2 5897.5 5929.4 5934.4 5959.4 5980.6 5673.6 5810.7 5842.8 5908.7 5955.7 4438.1 4477.6 4484.1 4507.6 4574.6 3931.8 4044.5 4045.5 4067.7 4079.2 5419.6 5421.8 5438.0 5453.6 5515.0 5902.4 5920.7 5921.8 5924.6 5926.1 5292.2 5394.7 5503.1 5518.4 5519.3 5123.9 5176.4 5197.5 5216.7 5253.8 6122.0 6127.8 6131.5 6142.7 6146.2 5729.0 5833.9 5881.5 5950.3 5961.2 6138.8 6144.9 6156.7 6177.9 6183.7 5846.3 5861.1 5917.9 5918.6 5929.1 5718.3 5773.4 5850.9 5859.2 6015.1 5752.1 5758.3 5773.8 5775.3 5777.7 5749.9 5753.7 5761.1 5763.4 5776.0 5510.9 5614.5 5654.2 5752.5 5797.9 5720.1 5781.5 5846.8 5854.7 5858.1 5472.3 5652.0 5725.5 5739.4 5755.0 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46260.27 Median:35982.55 stddev:77055.86 (214.1%) stddev-sans-first:77195.56 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: Values: 541.2 574.5 579.1 590.2 603.0 38336.6 38726.8 38939.6 39060.8 39063.0 42461.0 42964.0 43077.4 43167.6 43298.6 8779.7 8879.6 8909.5 8918.6 8959.5 8662.5 8692.1 8751.2 8756.6 8777.0 8681.0 8758.0 8765.3 8802.6 8811.6 8704.9 8710.0 8770.5 8771.1 8780.0 8615.3 8675.0 8743.2 8745.0 8778.8 39270.6 39385.6 39440.6 39483.8 39840.2 3430.6 3447.3 3639.5 3919.0 3937.6 29047.7 29479.3 29889.0 30592.4 30790.4 3817.4 3820.3 3880.3 3907.1 3924.7 267491.0 268528.0 268974.7 269848.0 269923.0 53831.2 55124.0 56602.4 56757.4 56898.1 66138.3 66795.0 66912.3 67106.0 67115.7 15422.5 15576.9 15642.8 15667.5 15670.6 11830.7 12030.0 12051.6 12052.1 12091.7 19106.9 19325.1 19432.9 19437.9 19470.7 7644.1 7693.8 7737.8 7772.7 7779.5 911.4 942.7 986.2 991.0 1068.8 28078.6 28230.7 28435.3 28483.9 28589.3 1043.9 1072.7 1097.4 1145.5 1178.2 14696.9 14786.6 14805.7 14910.1 14915.3 306584.0 312436.0 312814.0 312916.0 313065.0 50799.0 50884.2 51207.0 51267.7 51327.7 1320.4 1330.7 1331.5 1333.1 1333.3 26967.6 27523.3 27880.6 28100.9 28204.3 44629.3 44784.6 44883.8 44913.8 45037.8 302046.0 302120.0 302157.0 302287.0 302634.0 29414.9 31531.0 31702.2 31757.2 31800.7 37409.8 38224.4 38420.6 38618.4 38931.0 32895.3 35259.3 35885.3 36079.8 36374.1 34745.3 34862.1 35124.3 35613.6 35694.3 34285.3 34542.5 34699.5 34907.3 35090.5 31371.0 31864.8 32166.5 32290.7 32413.4 24703.6 24703.6 24782.5 25257.0 25329.4 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27378.31 Median:355.20 stddev:79736.50 (22448.2%) stddev-sans-first:79934.36 15:47:50 INFO - 2015-11-23 15:47:50,663 DEBUG : BROWSER_OUTPUT: Values: 353.3 354.8 355.6 359.4 359.9 14038.7 14108.5 16495.0 17002.7 17692.4 14545.2 16770.7 16959.6 17321.8 17376.8 5294.8 5443.6 5451.8 5455.0 5455.8 5273.3 5405.7 5444.0 5456.8 5468.4 5350.6 5374.8 5400.4 5422.6 5424.1 5428.6 5432.7 5435.7 5437.8 5458.0 5176.5 5196.4 5227.4 5238.0 5247.9 18965.0 19094.2 19551.3 19607.1 19614.2 2022.2 2087.9 2104.2 2119.2 2119.4 9097.7 9141.4 9234.3 11501.0 12011.9 1836.2 1840.9 1847.5 1882.9 1904.8 60135.7 61441.0 61800.7 62570.0 64440.7 9906.1 10031.2 10104.9 10147.3 10165.4 12763.9 12776.6 12832.2 12845.0 12883.2 7704.9 7795.8 7803.6 7818.7 7877.9 7773.4 7801.0 7814.2 7824.9 7849.5 4262.8 4286.6 4344.5 4353.9 4393.9 1743.2 1797.1 1808.7 1836.3 1837.5 886.7 938.6 1006.4 1008.4 1012.0 15757.9 15855.8 15956.9 16326.0 16377.7 941.0 941.3 944.6 955.4 959.0 9647.0 9649.7 9683.9 9757.2 9759.5 474962.0 481012.0 484352.0 496241.0 499338.0 77192.6 80985.6 81730.0 81733.6 82133.0 1113.6 1117.2 1126.1 1133.0 1141.2 14841.9 14927.0 15002.2 15094.3 15301.4 32693.0 32963.8 33589.0 33614.8 34645.3 44871.0 46267.0 47726.8 47953.5 48195.5 9037.5 9249.3 9379.3 9425.2 9578.5 10798.1 10803.7 16126.7 17025.0 17506.4 14583.5 14866.4 14938.7 15167.9 15246.7 14344.0 14462.2 14919.4 15050.1 15263.1 15129.0 15227.4 15357.5 15373.2 15656.6 9272.7 9591.3 9645.5 9650.3 9710.0 14734.0 14824.6 14939.6 14951.2 15248.5 15:47:50 INFO - 2015-11-23 15:47:50,664 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,664 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5308.54 Median:6423.28 stddev:2688.11 (41.8%) stddev-sans-first:2680.56 15:47:50 INFO - 2015-11-23 15:47:50,665 DEBUG : BROWSER_OUTPUT: Values: 1519.0 1677.9 1762.3 1764.5 1800.4 7249.8 7350.1 7594.5 7629.3 7666.9 7728.9 7797.9 7836.1 7862.0 7862.8 2253.7 2282.1 2284.4 2284.9 2286.5 2244.9 2268.8 2297.4 2299.2 2302.9 2133.8 2209.7 2214.6 2273.7 2287.9 2129.7 2154.5 2189.4 2200.2 2200.2 2271.5 2311.7 2313.0 2316.3 2316.9 7410.9 7484.7 7490.8 7499.7 7511.4 4640.1 4761.7 4779.2 4783.0 4786.2 2975.0 3027.1 3060.2 3085.3 3102.6 955.3 965.5 1005.8 1008.4 1010.3 10205.3 10221.0 10337.3 10343.5 10349.4 4073.5 4086.7 4176.1 4206.1 4219.1 8460.7 8493.4 8497.2 8510.3 8561.6 4616.9 4620.7 4641.1 4670.9 4689.6 4254.0 4256.5 4287.3 4300.6 4308.5 3472.1 3484.8 3523.4 3536.7 3543.7 1076.7 1080.7 1094.9 1095.0 1105.6 1042.7 1045.1 1106.0 1220.0 1366.5 6492.0 6501.0 6504.4 6530.0 6620.8 1124.1 1124.3 1137.8 1142.2 1149.5 5683.5 5704.1 5708.5 5720.1 5745.5 8785.5 8820.4 8969.3 9034.3 9059.2 8855.1 8856.7 8862.3 8867.8 8885.4 6866.8 6870.0 6962.7 7017.1 7110.4 6927.2 6956.2 6965.3 6980.9 6999.5 7855.3 8091.5 8114.7 8121.9 8140.8 8132.3 8291.9 8325.6 8352.7 8466.7 6494.7 6496.4 6504.8 6667.5 6702.4 7294.0 7359.7 7397.7 7403.8 7433.6 6114.5 6836.6 7085.3 7105.8 7232.1 6926.2 6956.8 6958.7 7028.5 7062.4 6419.9 6635.4 6656.3 6676.0 6699.8 6417.3 6426.6 6437.2 6446.6 6458.7 6484.1 6542.2 6580.0 6592.0 6615.5 15:47:50 INFO - 2015-11-23 15:47:50,665 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,666 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5647.03 Median:6408.38 stddev:1754.58 (27.4%) stddev-sans-first:1713.57 15:47:50 INFO - 2015-11-23 15:47:50,666 DEBUG : BROWSER_OUTPUT: Values: 332.7 334.7 337.0 338.9 341.3 6389.0 6418.0 6442.1 6501.4 6598.7 6373.8 6411.5 6411.6 6438.1 6442.0 4815.9 4819.8 4822.3 4825.8 4827.1 4817.5 4819.7 4823.0 4828.1 4828.4 4581.7 4757.3 4762.7 4765.6 4776.6 4718.9 4731.0 4748.2 4753.3 4755.8 4070.2 4075.9 4081.2 4084.0 4089.1 6047.8 6050.1 6074.9 6078.8 6080.3 5454.5 5490.8 5508.0 5534.7 5547.8 6684.4 6705.6 6727.4 6742.6 6743.9 4516.4 4527.5 4555.6 4566.5 4569.5 6871.0 6959.8 7014.4 7015.1 7036.6 4620.0 4631.4 4633.8 4637.7 4641.9 4701.9 4708.2 4709.9 4712.4 4713.9 5486.5 5503.3 5511.7 5512.7 5517.4 6579.3 6761.5 6811.8 6820.3 6856.1 1599.6 1643.6 1664.2 1665.3 1666.5 1069.6 1070.0 1080.7 1089.4 1092.5 6312.0 6369.2 6399.7 6405.3 6418.9 6912.5 6922.8 6933.4 6940.2 6963.2 6336.7 6354.2 6370.9 6384.9 6394.8 3827.6 3853.8 3873.3 3893.0 3898.8 7345.4 7362.3 7370.6 7372.2 7393.7 7080.9 7229.7 7300.1 7304.3 7313.5 7319.0 7356.9 7386.7 7388.8 7389.9 7089.5 7104.3 7112.2 7121.3 7124.3 6877.6 6978.8 7019.0 7021.7 7036.1 7289.6 7351.0 7360.9 7379.9 7380.4 4627.6 4656.7 4662.8 4668.2 4677.1 6913.3 6954.6 7079.2 7085.3 7087.3 6784.1 6787.3 6804.8 6816.7 6823.3 6817.6 6839.6 6850.6 6856.5 6877.2 6525.6 6759.9 6764.9 6769.7 6776.0 6886.6 6912.5 6924.4 6927.9 6935.2 6746.6 6753.2 6755.2 6760.7 6764.9 15:47:50 INFO - 2015-11-23 15:47:50,666 DEBUG : BROWSER_OUTPUT: 15:47:50 INFO - 2015-11-23 15:47:50,666 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13792.01 Median:50569.37 stddev:16279.91 (32.2%) stddev-sans-first:16295.99 15:47:50 INFO - 2015-11-23 15:47:50,667 DEBUG : BROWSER_OUTPUT: Values: 721.5 735.5 735.6 738.6 833.8 13671.1 14008.2 14023.6 14070.7 14071.2 12979.8 14570.1 14585.6 14673.6 14709.9 813.7 818.9 828.3 831.3 835.6 817.7 821.9 822.2 822.4 822.5 863.8 866.8 867.0 868.6 869.7 865.4 868.7 868.9 876.5 882.3 638.5 638.9 639.9 642.2 644.4 14084.0 14263.9 14326.9 14353.3 14362.8 11888.1 11901.8 11924.3 12199.3 12253.1 10226.4 10358.1 10627.8 10693.0 10731.7 3633.8 3636.6 3640.7 3670.5 3780.3 44583.0 44739.0 45176.1 45219.5 45327.8 9530.4 9548.6 9579.6 9735.2 9953.0 17669.2 17709.1 17770.3 17772.1 17774.6 6896.3 6992.3 7157.7 7160.7 7384.9 4163.0 4219.3 4256.3 4260.6 4290.2 2971.1 2975.6 2984.7 2985.1 2994.6 546.6 562.4 565.8 566.6 568.9 559.4 576.1 578.9 580.2 587.3 7388.0 7508.6 7762.8 7769.7 7790.2 570.2 574.2 583.2 598.4 605.2 3623.3 3711.4 3863.5 3987.1 4026.9 51399.0 51635.5 57663.7 58195.0 58632.1 53693.7 53976.7 54043.2 57620.4 57635.4 50346.5 50792.2 51351.7 53180.5 53853.2 7571.2 7730.2 7859.9 7876.0 8096.0 33497.2 33636.5 34290.3 34935.0 35088.5 43389.0 44161.0 45059.8 45338.5 45748.8 10810.8 10831.8 10916.9 11015.4 11441.0 11025.9 11220.7 11269.6 11283.0 11662.2 10568.0 10721.5 10882.1 11145.4 11440.5 10920.0 11067.7 11100.8 11165.2 11553.7 10293.2 10544.7 10761.8 10795.5 11074.1 9279.4 9346.7 9378.0 9397.7 9631.0 8425.4 8636.3 8645.4 9051.1 9306.4 15:47:50 INFO - 2015-11-23 15:47:50,667 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:47:50 INFO - 2015-11-23 15:47:50,668 DEBUG : BROWSER_OUTPUT: 15:47:51 INFO - 2015-11-23 15:47:51,305 INFO : Browser exited with error code: 0 15:47:51 INFO - 2015-11-23 15:47:51,326 INFO : Completed test dromaeo_css (00:18:31) 15:47:51 INFO - 2015-11-23 15:47:51,327 INFO : Starting test kraken 15:47:51 INFO - 2015-11-23 15:47:51,327 DEBUG : operating with platform_type : linux_ 15:47:51 INFO - 2015-11-23 15:47:51,327 INFO : Initialising browser for kraken test... 15:47:51 INFO - 2015-11-23 15:47:51,333 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTxmPYk/profile http://localhost:37490/getInfo.html 15:47:55 INFO - 2015-11-23 15:47:55,880 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:47:55 INFO - 2015-11-23 15:47:55,881 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:47:55 INFO - 2015-11-23 15:47:55,881 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:47:55 INFO - 2015-11-23 15:47:55,881 DEBUG : BROWSER_OUTPUT: __metrics 15:47:56 INFO - 2015-11-23 15:47:56,873 INFO : Browser initialized. 15:47:56 INFO - 2015-11-23 15:47:56,874 INFO : Running cycle 1/1 for kraken test... 15:47:56 INFO - 2015-11-23 15:47:56,874 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTxmPYk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:48:08 INFO - 2015-11-23 15:48:08,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 141832192 15:48:08 INFO - 2015-11-23 15:48:08,674 DEBUG : BROWSER_OUTPUT: 15:48:11 INFO - 2015-11-23 15:48:11,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:11 INFO - 2015-11-23 15:48:11,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 142274560 15:48:11 INFO - 2015-11-23 15:48:11,801 DEBUG : BROWSER_OUTPUT: 15:48:14 INFO - 2015-11-23 15:48:14,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-dft) 15:48:15 INFO - 2015-11-23 15:48:15,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 142794752 15:48:15 INFO - 2015-11-23 15:48:15,006 DEBUG : BROWSER_OUTPUT: 15:48:17 INFO - 2015-11-23 15:48:17,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-fft) 15:48:18 INFO - 2015-11-23 15:48:18,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 137502720 15:48:18 INFO - 2015-11-23 15:48:18,428 DEBUG : BROWSER_OUTPUT: 15:48:20 INFO - 2015-11-23 15:48:20,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37490/tests/kraken/driver.html?testName=audio-oscillator) 15:48:21 INFO - 2015-11-23 15:48:21,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 138067968 15:48:21 INFO - 2015-11-23 15:48:21,002 DEBUG : BROWSER_OUTPUT: 15:48:23 INFO - 2015-11-23 15:48:23,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:23 INFO - 2015-11-23 15:48:23,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 139231232 15:48:23 INFO - 2015-11-23 15:48:23,774 DEBUG : BROWSER_OUTPUT: 15:48:26 INFO - 2015-11-23 15:48:26,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37490/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:27 INFO - 2015-11-23 15:48:27,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 15:48:27 INFO - 2015-11-23 15:48:27,371 DEBUG : BROWSER_OUTPUT: 15:48:30 INFO - 2015-11-23 15:48:30,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37490/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:31 INFO - 2015-11-23 15:48:31,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 140472320 15:48:31 INFO - 2015-11-23 15:48:31,363 DEBUG : BROWSER_OUTPUT: 15:48:34 INFO - 2015-11-23 15:48:34,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37490/tests/kraken/driver.html?testName=json-parse-financial) 15:48:34 INFO - 2015-11-23 15:48:34,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 15:48:34 INFO - 2015-11-23 15:48:34,800 DEBUG : BROWSER_OUTPUT: 15:48:36 INFO - 2015-11-23 15:48:36,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:36 INFO - 2015-11-23 15:48:36,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 139317248 15:48:36 INFO - 2015-11-23 15:48:36,977 DEBUG : BROWSER_OUTPUT: 15:48:38 INFO - 2015-11-23 15:48:38,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:39 INFO - 2015-11-23 15:48:39,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 139096064 15:48:39 INFO - 2015-11-23 15:48:39,416 DEBUG : BROWSER_OUTPUT: 15:48:41 INFO - 2015-11-23 15:48:41,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:42 INFO - 2015-11-23 15:48:42,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 139997184 15:48:42 INFO - 2015-11-23 15:48:42,076 DEBUG : BROWSER_OUTPUT: 15:48:44 INFO - 2015-11-23 15:48:44,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:45 INFO - 2015-11-23 15:48:45,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 139767808 15:48:45 INFO - 2015-11-23 15:48:45,154 DEBUG : BROWSER_OUTPUT: 15:48:47 INFO - 2015-11-23 15:48:47,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:48 INFO - 2015-11-23 15:48:48,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 140828672 15:48:48 INFO - 2015-11-23 15:48:48,315 DEBUG : BROWSER_OUTPUT: 15:48:49 INFO - 2015-11-23 15:48:49,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37490/tests/kraken/driver.html?testName=ai-astar) 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:48:50 INFO - 2015-11-23 15:48:50,241 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;111;110;111;123;112;112;110;111 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;127;154;172;128;156;151;129;163;132 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;163;162;160;162;163;161;173;163 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;70;73;71;71;132;72;71;72 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;139;92;93;94;139;93;93;132 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;109;109;110;109;110;110 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;148;147;146;147;145;147;147;146 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;98;96;96;95;96 15:48:50 INFO - 2015-11-23 15:48:50,242 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;64;64;63;64;62;63;64;65;62 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;69;69;70;69;69 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;94;84;85;88;84;84;90;93;84 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;121;124;118;119;130;126;133;122;117 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;149;149;151;157;141;155;152;142;154 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;71;68;65;67;67;69;67;65 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:48:50 INFO - 2015-11-23 15:48:50,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,710 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322530235__endTimestamp 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.65 (4.2%) stddev-sans-first:4.93 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 111.0 110.0 111.0 123.0 112.0 112.0 110.0 111.0 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,244 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:16.15 (10.6%) stddev-sans-first:17.04 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: Values: 151.0 127.0 154.0 172.0 128.0 156.0 151.0 129.0 163.0 132.0 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:3.60 (2.2%) stddev-sans-first:3.80 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 163.0 162.0 160.0 162.0 163.0 161.0 173.0 163.0 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.50 Median:71.50 stddev:19.17 (26.8%) stddev-sans-first:20.19 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 73.0 71.0 71.0 132.0 72.0 71.0 72.0 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:21.12 (22.7%) stddev-sans-first:21.93 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 139.0 92.0 93.0 94.0 139.0 93.0 93.0 132.0 15:48:50 INFO - 2015-11-23 15:48:50,245 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:0.88 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 148.0 147.0 146.0 147.0 145.0 147.0 147.0 146.0 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 15:48:50 INFO - 2015-11-23 15:48:50,246 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 95.0 96.0 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 63.0 64.0 62.0 63.0 64.0 65.0 62.0 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 69.0 69.0 70.0 69.0 69.0 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:4.09 (4.7%) stddev-sans-first:4.09 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: Values: 83.0 94.0 84.0 85.0 88.0 84.0 84.0 90.0 93.0 84.0 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:123.00 stddev:5.27 (4.3%) stddev-sans-first:5.48 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: Values: 120.0 121.0 124.0 118.0 119.0 130.0 126.0 133.0 122.0 117.0 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.50 stddev:5.27 (3.5%) stddev-sans-first:5.50 15:48:50 INFO - 2015-11-23 15:48:50,247 DEBUG : BROWSER_OUTPUT: Values: 153.0 149.0 149.0 151.0 157.0 141.0 155.0 152.0 142.0 154.0 15:48:50 INFO - 2015-11-23 15:48:50,248 DEBUG : BROWSER_OUTPUT: 15:48:50 INFO - 2015-11-23 15:48:50,248 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.90 (2.8%) stddev-sans-first:1.92 15:48:50 INFO - 2015-11-23 15:48:50,248 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 71.0 68.0 65.0 67.0 67.0 69.0 67.0 65.0 15:48:50 INFO - 2015-11-23 15:48:50,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:48:50 INFO - 2015-11-23 15:48:50,248 DEBUG : BROWSER_OUTPUT: 15:48:51 INFO - 2015-11-23 15:48:51,285 INFO : Browser exited with error code: 0 15:48:51 INFO - 2015-11-23 15:48:51,336 INFO : Completed test kraken (00:01:00) 15:48:51 INFO - 2015-11-23 15:48:51,336 INFO : Starting test v8_7 15:48:51 INFO - 2015-11-23 15:48:51,336 DEBUG : operating with platform_type : linux_ 15:48:51 INFO - 2015-11-23 15:48:51,336 INFO : Initialising browser for v8_7 test... 15:48:51 INFO - 2015-11-23 15:48:51,342 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptR0Loi/profile http://localhost:37490/getInfo.html 15:48:56 INFO - 2015-11-23 15:48:56,073 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:48:56 INFO - 2015-11-23 15:48:56,073 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:48:56 INFO - 2015-11-23 15:48:56,073 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:48:56 INFO - 2015-11-23 15:48:56,073 DEBUG : BROWSER_OUTPUT: __metrics 15:48:57 INFO - 2015-11-23 15:48:57,088 INFO : Browser initialized. 15:48:57 INFO - 2015-11-23 15:48:57,089 INFO : Running cycle 1/1 for v8_7 test... 15:48:57 INFO - 2015-11-23 15:48:57,089 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptR0Loi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:49:08 INFO - 2015-11-23 15:49:08,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 141840384 15:49:08 INFO - 2015-11-23 15:49:08,906 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37490/tests/v8_7/run.html (next: http://localhost:37490/tests/v8_7/run.html) 15:49:30 INFO - 2015-11-23 15:49:30,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 138342400 15:49:30 INFO - 2015-11-23 15:49:30,591 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,591 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:49:30 INFO - 2015-11-23 15:49:30,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:49:30 INFO - 2015-11-23 15:49:30,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |0;Richards;184.1959845275373 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.87359441644048 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.58361391694723 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4990.049751243781 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1051.5247108307046 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |5;Earley;747.9431563201197 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |8;Splay;658.1196581196581 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:49:30 INFO - 2015-11-23 15:49:30,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1448322570584__endTimestamp 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:184.20 Median:184.20 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: Values: 184.2 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.87 Median:193.87 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: Values: 193.9 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: Values: 280.6 15:49:30 INFO - 2015-11-23 15:49:30,593 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4990.05 Median:4990.05 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: Values: 4990.0 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: Values: 1051.5 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:747.94 Median:747.94 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: Values: 747.9 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: Values: 12207.3 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: Values: 25350.0 15:49:30 INFO - 2015-11-23 15:49:30,594 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:658.12 Median:658.12 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: Values: 658.1 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:49:30 INFO - 2015-11-23 15:49:30,595 DEBUG : BROWSER_OUTPUT: 15:49:31 INFO - 2015-11-23 15:49:31,477 INFO : Browser exited with error code: 0 15:49:31 INFO - 2015-11-23 15:49:31,496 INFO : Completed test v8_7 (00:00:40) 15:49:31 INFO - 2015-11-23 15:49:31,600 INFO : Completed test suite (00:20:11) 15:49:31 INFO - 2015-11-23 15:49:31,600 DEBUG : Working with test: dromaeo_css 15:49:31 INFO - 2015-11-23 15:49:31,601 DEBUG : Generating results file: dromaeo_css 15:49:31 INFO - 2015-11-23 15:49:31,602 DEBUG : Working with test: kraken 15:49:31 INFO - 2015-11-23 15:49:31,602 DEBUG : Generating results file: kraken 15:49:31 INFO - 2015-11-23 15:49:31,602 INFO : javascript benchmark 15:49:31 INFO - 2015-11-23 15:49:31,602 DEBUG : Working with test: v8_7 15:49:31 INFO - 2015-11-23 15:49:31,602 DEBUG : Generating results file: v8_7 15:49:31 INFO - 2015-11-23 15:49:31,603 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:31 INFO - 2015-11-23 15:49:31,649 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 15:49:31 INFO - 2015-11-23 15:49:31,650 DEBUG : process_Request line: dromaeo_css 7043.56 graph.html#tests=[[72,64,43]] 15:49:31 INFO - 2015-11-23 15:49:31,650 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:31 INFO - 2015-11-23 15:49:31,680 DEBUG : process_Request line: kraken 1517.20 graph.html#tests=[[232,64,43]] 15:49:31 INFO - 2015-11-23 15:49:31,680 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:31 INFO - 2015-11-23 15:49:31,705 DEBUG : process_Request line: v8_7 20926.09 graph.html#tests=[[230,64,43]] 15:49:31 INFO - 2015-11-23 15:49:31,707 INFO : javascript benchmark 15:49:31 INFO - 2015-11-23 15:49:31,709 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3245.0, 3263.5104734289866, 3303.141183292343, 3304.322613864158, 3317.8672853085877, 5265.18389649604, 5318.707471089088, 5364.463553644634, 5402.6758394496355, 5415.837524874255, 5296.761645725942, 5374.435684253156, 5442.346918369801, 5495.670259784406, 5503.091989821674, 4742.217534106868, 4967.205247160446, 5189.351331083614, 5196.818111366103, 5212.400573933989, 4872.731999740013, 5137.922931156036, 5149.382074151088, 5162.303089082963, 5194.142966410556, 4950.900981980359, 5008.198688209887, 5062.797488100471, 5066.392032956069, 5091.821786237501, 5026.070177017264, 5033.043721692903, 5035.899282014339, 5075.6447048706605, 5087.771050302746, 4868.829590964299, 4950.405951285833, 5019.171836646985, 5031.295618613397, 5040.42035165957, 5168.3539557555305, 5197.740112994373, 5223.37319521656, 5233.371995360543, 5288.233206185082, 5811.941880581182, 5812.854678633025, 5816.912746308809, 5820.272465941757, 5890.705464726747, 5667.064934285879, 5757.222774925373, 5790.189373487715, 5857.502112320458, 5870.911936320958, 5577.9959607270675, 5580.804671836548, 5594.412586678422, 5596.916046259309, 5610.270664813589, 5985.40145985398, 6025.638461692312, 6041.275046994301, 6044.486218671462, 6044.727987240584, 5668.0647693130995, 5771.509421699118, 5841.153032810219, 5855.765769369263, 5897.587168898136, 5956.851078723066, 5963.0459126539545, 5970.76116955317, 5973.223480947449, 5979.222701048836, 5897.498712609477, 5929.377415371324, 5934.406559344117, 5959.404059594092, 5980.641161530322, 5673.602847800615, 5810.709464526842, 5842.766289348463, 5908.675022873697, 5955.67243801595, 4438.090191510797, 4477.552244775561, 4484.1255955088445, 4507.639388848885, 4574.611158051536, 3931.7837518936735, 4044.5348784889525, 4045.4538637284177, 4067.6745860331694, 4079.204555111725, 5419.6477228980775, 5421.83734487966, 5438.021156191844, 5453.618246722771, 5515.0, 5902.4097590240635, 5920.733566989496, 5921.792737254262, 5924.585279030426, 5926.140709597084, 5292.179712144623, 5394.703291318937, 5503.147012213113, 5518.365387980353, 5519.31008623922, 5123.897522049539, 5176.430592634807, 5197.454267301954, 5216.713080780593, 5253.789848406021, 6122.0, 6127.84680382994, 6131.540134489931, 6142.723577439026, 6146.170267013986, 5729.0, 5833.883322333614, 5881.5000724937145, 5950.34546199909, 5961.195238642727, 6138.81758342749, 6144.938550614436, 6156.722947467285, 6177.938220617736, 6183.721732522137, 5846.327672317738, 5861.062230043172, 5917.940820591911, 5918.579540910065, 5929.110633405024, 5718.25662663851, 5773.364929857797, 5850.94149058504, 5859.179714839841, 6015.097735339734, 5752.050911599539, 5758.280214973129, 5773.797917072882, 5775.306963164448, 5777.653340799566, 5749.913751293818, 5753.741081651419, 5761.078227483583, 5763.423657634203, 5775.971120144372, 5510.944890551204, 5614.522765564972, 5654.208410822571, 5752.453516915886, 5797.884042319046, 5720.11338242573, 5781.537477001913, 5846.824595262149, 5854.736536855937, 5858.091995740667, 5472.26124473207, 5651.971740141273, 5725.51333136688, 5739.368669446274, 5754.971225144015], "unit": "ms", "name": "dojo.html", "value": 5427.951162311374}, {"lowerIsBetter": false, "replicates": [541.2236728979426, 574.4628772098091, 579.1284117403309, 590.1649166429503, 603.0, 38336.616633833655, 38726.8063659682, 38939.610603893954, 39060.80469597655, 39063.0, 42461.0, 42964.0, 43077.35383969243, 43167.568324316744, 43298.56701432985, 8779.69271075511, 8879.556022198896, 8909.509976951265, 8918.598663060146, 8959.462432254053, 8662.480251184918, 8692.087330830267, 8751.168638979287, 8756.60595273211, 8777.034526202113, 8681.0, 8757.95621021894, 8765.298776097898, 8802.559872006406, 8811.64753409866, 8704.869426958601, 8710.0, 8770.473771573726, 8771.12288771124, 8779.95610021949, 8615.267702245317, 8675.0, 8743.213110820057, 8744.956275218647, 8778.824423511558, 39270.60729392726, 39385.60614393877, 39440.60559394398, 39483.8025809872, 39840.20319593621, 3430.588329400463, 3447.293304872495, 3639.508666330038, 3918.960810391888, 3937.606239376068, 29047.70952290471, 29479.263018424495, 29889.0, 30592.388152237054, 30790.38419231625, 3817.408301713239, 3820.2550502651993, 3880.2821478026653, 3907.081835768592, 3924.666403355718, 267491.0, 268528.0, 268974.6551267251, 269848.0, 269923.0, 53831.19253211205, 55124.0, 56602.43397566054, 56757.432425675215, 56898.14652780211, 66138.33861661419, 66795.0, 66912.33087669159, 67106.0, 67115.66442167855, 15422.537323880302, 15576.922115389578, 15642.765358519631, 15667.529974100795, 15670.608234793994, 11830.704232394259, 12029.954907665719, 12051.57819476314, 12052.096092793076, 12091.697707557381, 19106.904465477583, 19325.13036913314, 19432.902835485733, 19437.902810485855, 19470.70793938092, 7644.120926093459, 7693.846123077619, 7737.767866964, 7772.65023073963, 7779.533228006338, 911.4258017448965, 942.7171848445576, 986.225812736998, 990.980180396388, 1068.8396740488988, 28078.578821317697, 28230.71769282322, 28435.28911777181, 28483.857580711963, 28589.285267868054, 1043.879953805307, 1072.651388298806, 1097.4183682648209, 1145.473082382097, 1178.1517307538559, 14696.853031469549, 14786.63033424173, 14805.703885922221, 14910.105393676415, 14915.328810203568, 306584.0, 312436.0, 312814.0, 312916.0, 313065.0, 50799.0, 50884.236736448984, 51207.0, 51267.743661281456, 51327.743361282955, 1320.42561485754, 1330.6673331667084, 1331.5472739268696, 1333.1001573937554, 1333.3333333333333, 26967.595486067334, 27523.31191720143, 27880.58179127355, 28100.859495702392, 28204.294892627848, 44629.330560042275, 44784.552154478035, 44883.77558112189, 44913.77543112264, 45037.77481112573, 302046.0, 302120.0, 302157.0, 302287.0, 302634.0, 29414.852925735235, 31531.0, 31702.207444814063, 31757.20606984844, 31800.681993179773, 37409.81295093507, 38224.42663360108, 38420.6157938417, 38618.42072368861, 38931.0, 32895.342093157524, 35259.29481410409, 35885.28229435344, 36079.81960090183, 36374.09064773402, 34745.30509389849, 34862.12844678904, 35124.297514050086, 35613.64386356103, 35694.28611427705, 34285.31429371348, 34542.48186277258, 34699.47950780791, 34907.30185396227, 35090.473642895886, 31371.0, 31864.840675796473, 32166.51750223795, 32290.677093228765, 32413.35173296568, 24703.62944555797, 24703.62944555869, 24782.504349913263, 25257.0, 25329.366765830266], "unit": "ms", "name": "ext.html", "value": 18420.622537972115}, {"lowerIsBetter": false, "replicates": [353.33925559204295, 354.8491890946349, 355.55555555555554, 359.4410691374912, 359.9352116619009, 14038.719225615481, 14108.506202282922, 16495.0, 17002.659946801057, 17692.38076667315, 14545.200013999225, 16770.66458670826, 16959.558437532793, 17321.82678173218, 17376.82623173768, 5294.841154765353, 5443.564514838803, 5451.781928722847, 5454.972725136368, 5455.781768729246, 5273.288106105665, 5405.702686352249, 5443.972780136113, 5456.781728730846, 5468.398476167618, 5350.625456218067, 5374.7850085996515, 5400.351957765074, 5422.593305502083, 5424.105022671254, 5428.647137936041, 5432.674039557639, 5435.673859568419, 5437.809676661298, 5458.0, 5176.534111929906, 5196.350456192976, 5227.424983251839, 5237.973810130963, 5247.895042099137, 18965.0, 19094.23623055076, 19551.315703950437, 19607.117679704304, 19614.215431382727, 2022.1810166882435, 2087.8538502304846, 2104.1793700456833, 2119.162930642403, 2119.4336219695692, 9097.681581144629, 9141.360104792668, 9234.307426943005, 11501.0, 12011.858873407013, 1836.2012524551862, 1840.8987505687182, 1847.4827048426462, 1882.8587855910725, 1904.8094940662086, 60135.69932150311, 61441.0, 61800.69099654518, 62570.0, 64440.677796611184, 9906.108450239513, 10031.197504199647, 10104.949475252724, 10147.34042287249, 10165.440900750382, 12763.872361276453, 12776.552820651232, 12832.165909215872, 12845.0, 12883.227006379648, 7704.8844267336035, 7795.766127016199, 7803.609819509002, 7818.687252509836, 7877.921220787834, 7773.378129749606, 7801.0, 7814.179511151361, 7824.882626760603, 7849.529028258323, 4262.808173632194, 4286.571342865688, 4344.45694288214, 4353.891152721208, 4393.890152746143, 1743.1632816248273, 1797.1014492753623, 1808.6563552925165, 1836.3113832312883, 1837.4855040588657, 886.7029545102334, 938.558877327655, 1006.4112494190834, 1008.4302369161401, 1011.9779023186487, 15757.921210393875, 15855.841441585668, 15956.920215399081, 16326.020438773712, 16377.67244655124, 940.9837375634298, 941.2799208605422, 944.6268723854039, 955.4124213608719, 959.0, 9646.951765241129, 9649.710508684751, 9683.90316096844, 9757.219422446187, 9759.512024398893, 474962.0, 481012.0, 484352.0, 496241.0, 499338.0, 77192.61403692946, 80985.59507202545, 81730.0, 81733.59133204295, 82133.0, 1113.5935383584933, 1117.212365282474, 1126.132877684195, 1133.0482394788417, 1141.2353723005606, 14841.925790371411, 14927.0, 15002.249887505362, 15094.320755566245, 15301.387944482096, 32693.0, 32963.835180823946, 33589.0, 33614.83192584021, 34645.307093857475, 44871.0, 46267.0, 47726.76136619295, 47953.520464796304, 48195.5180448191, 9037.50293733851, 9249.260059195114, 9379.296552758708, 9425.151736343762, 9578.521073946136, 10798.082163015917, 10803.675889723007, 16126.67746645084, 17025.0, 17506.387276445264, 14583.489577864724, 14866.405343786128, 14938.701225975637, 15167.938244322791, 15246.695066098395, 14344.0, 14462.20457874827, 14919.403223870924, 15050.096994180385, 15263.08421494714, 15129.0, 15227.390904363701, 15357.462488812838, 15373.1544765039, 15656.608584785472, 9272.675456358995, 9591.328606997722, 9645.469499177612, 9650.324477286804, 9709.951450242703, 14734.0, 14824.555263342118, 14939.592820118309, 14951.177685227416, 15248.542543723706], "unit": "ms", "name": "jquery.html", "value": 8849.246462274352}, {"lowerIsBetter": false, "replicates": [1519.043002908169, 1677.9077150756707, 1762.277466238842, 1764.541219282986, 1800.3698705453094, 7249.782506524806, 7350.117985841706, 7594.506357086785, 7629.275218854207, 7666.923330766691, 7728.92271077289, 7797.883031754528, 7836.13802481728, 7861.960690196555, 7862.803429914255, 2253.6619507073947, 2282.0643536150183, 2284.4403121235237, 2284.885755712216, 2286.542691461706, 2244.921427750029, 2268.8184945204425, 2297.448612333036, 2299.1608063056947, 2302.9078836846506, 2133.797289257526, 2209.7016902718087, 2214.568159208955, 2273.7385200701965, 2287.874166920819, 2129.659254519285, 2154.450615093149, 2189.37602783206, 2200.1749343996003, 2200.1969281212323, 2271.5002699406105, 2311.7457079721216, 2312.953740925189, 2316.293530473205, 2316.872572008539, 7410.925890741078, 7484.663190156456, 7490.812729681802, 7499.662515186775, 7511.436642251853, 4640.118377508263, 4761.666683332168, 4779.163646361872, 4783.043391321749, 4786.1863483207935, 2974.9553756693667, 3027.137265879214, 3060.1737530866762, 3085.305806193611, 3102.5811515445575, 955.2501286490142, 965.5124162297994, 1005.8390657494839, 1008.3848852200152, 1010.3382284603597, 10205.336653117523, 10221.0, 10337.328073675262, 10343.534540945675, 10349.379037257864, 4073.51117865858, 4086.7139300248696, 4176.14389050244, 4206.095689426788, 4219.092895027584, 8460.661573537112, 8493.405461617627, 8497.192766687154, 8510.319174466027, 8561.614727337284, 4616.884577885579, 4620.67655264135, 4641.071785642885, 4670.859874203779, 4689.60138388234, 4254.042840360956, 4256.5105012923295, 4287.292596721569, 4300.634446072057, 4308.482982042175, 3472.0972547137926, 3484.756067075331, 3523.3834079036064, 3536.734744894143, 3543.6987856032524, 1076.7469644633504, 1080.6541906589816, 1094.9124070074374, 1094.950727217277, 1105.5909313554037, 1042.7028296935337, 1045.0959919669583, 1105.9557617695364, 1219.9817002744967, 1366.5285476510587, 6492.0, 6500.967495162494, 6504.414602685781, 6530.0, 6620.768273110418, 1124.128800179867, 1124.2804605052772, 1137.8122609769296, 1142.1719253541116, 1149.5057125435976, 5683.54531637468, 5704.058830293038, 5708.543316534668, 5720.08478643415, 5745.511631511368, 8785.516796576121, 8820.382573219813, 8969.327300452493, 9034.277257819358, 9059.184673379295, 8855.070217627057, 8856.690015849414, 8862.335324850534, 8867.822643547093, 8885.42244754089, 6866.828329291708, 6869.9999999999, 6962.651867406609, 7017.087778588751, 7110.395616372666, 6927.238003819677, 6956.2000369958105, 6965.303469652994, 6980.895286570807, 6999.545029573062, 7855.253750893656, 8091.514509129471, 8114.715984940499, 8121.878171827546, 8140.75577732669, 8132.308753755997, 8291.875621865798, 8325.583720814057, 8352.749417517483, 8466.74599762008, 6494.74021039172, 6496.447801936888, 6504.804855854332, 6667.49993750461, 6702.36327548882, 7294.015307933361, 7359.668814903235, 7397.667104980181, 7403.8149046274275, 7433.591152486449, 6114.510839132769, 6836.589804611739, 7085.326893945067, 7105.75129870452, 7232.059832221988, 6926.238113807376, 6956.79129626112, 6958.652067396509, 7028.543144695578, 7062.39969602569, 6419.903701444576, 6635.369639884203, 6656.334366563305, 6676.0, 6699.832504187434, 6417.326180750954, 6426.646534440651, 6437.195350581177, 6446.64543450096, 6458.67706614658, 6484.1246431733, 6542.182227221598, 6580.0, 6591.967040164768, 6615.536912416084], "unit": "ms", "name": "mootools.html", "value": 4396.388715146968}, {"lowerIsBetter": false, "replicates": [332.70577453705084, 334.66199138869734, 336.9595648522178, 338.91018879996807, 341.332694582092, 6389.0, 6418.0, 6442.065900444439, 6501.382368674968, 6598.703058362374, 6373.776917807878, 6411.487081033518, 6411.551191416591, 6438.066480360345, 6441.967790161054, 4815.879603009936, 4819.759012049383, 4822.324874517571, 4825.831095911643, 4827.082854257697, 4817.470078291385, 4819.734914579697, 4822.951770482303, 4828.106800241949, 4828.396450443694, 4581.748003859786, 4757.26262429324, 4762.666613337068, 4765.642576806753, 4776.641751868607, 4718.905621887578, 4731.0, 4748.240281554952, 4753.287006948951, 4755.809767609291, 4070.1656160487323, 4075.9388609170887, 4081.244969680589, 4083.959160408417, 4089.0595163112653, 6047.7580896764075, 6050.122732203806, 6074.908876366858, 6078.75684972605, 6080.270367555878, 5454.53636440903, 5490.780368785244, 5508.0, 5534.695591742453, 5547.77808887644, 6684.398404143651, 6705.564138330993, 6727.394534491919, 6742.595444273359, 6743.93256067438, 4516.412866327357, 4527.501974782771, 4555.589996900262, 4566.520515345874, 4569.451665800092, 6871.0, 6959.826004349881, 7014.438844892396, 7015.123109611299, 7036.648167591651, 4619.95380046202, 4631.444226692818, 4633.791479383436, 4637.698549594265, 4641.883952901205, 4701.905961880743, 4708.246680531099, 4709.882252943704, 4712.410948631421, 4713.858584242478, 5486.506214440719, 5503.3120859892515, 5511.669299842022, 5512.724363781795, 5517.420670829585, 6579.342065793382, 6761.4590832733265, 6811.761588344483, 6820.31796820314, 6856.108705868305, 1599.6000999750063, 1643.6137507685685, 1664.167916041979, 1665.267282395742, 1666.500049985024, 1069.556134204312, 1070.0209308482806, 1080.6974047266779, 1089.3681664634494, 1092.502911175429, 6312.0, 6369.20384951881, 6399.680015999182, 6405.263394709668, 6418.8716225675225, 6912.516123871382, 6922.757703480354, 6933.37599616037, 6940.236573976858, 6963.234044255128, 6336.651484168415, 6354.17395738551, 6370.872582548323, 6384.936150638527, 6394.84012899672, 3827.6363745444137, 3853.788041657736, 3873.32216862048, 3892.9805350973065, 3898.8440462381755, 7345.375643070292, 7362.300581444754, 7370.557766534025, 7372.189059203483, 7393.667284972189, 7080.92919070813, 7229.7469588564145, 7300.050993370828, 7304.342609165201, 7313.524620899624, 7318.96340518294, 7356.852862942711, 7386.667599958015, 7388.815279617945, 7389.889151662622, 7089.539179953286, 7104.254053324326, 7112.217656057726, 7121.287871212838, 7124.323189297009, 6877.552959057645, 6978.79063628092, 7019.0, 7021.719131234898, 7036.085308909809, 7289.562626242442, 7350.96324518374, 7360.852782944204, 7379.9262007381385, 7380.44646651514, 4627.5603817637275, 4656.674032817806, 4662.813487460464, 4668.229742092517, 4677.111348843709, 6913.343232392915, 6954.617496037767, 7079.22128565847, 7085.256048114874, 7087.255838136922, 6784.050232967487, 6787.287334829772, 6804.795856124324, 6816.727330906709, 6823.317668233137, 6817.5909445433435, 6839.555428897106, 6850.554713943578, 6856.457297108111, 6877.2091209509545, 6525.64108973992, 6759.932400675931, 6764.93235067643, 6769.661516924232, 6775.966120169368, 6886.621235832077, 6912.4815638828295, 6924.4460443165435, 6927.930720692729, 6935.202451718117, 6746.595204287562, 6753.223379311442, 6755.1556055493065, 6760.661966901734, 6764.932350676627], "unit": "ms", "name": "prototype.html", "value": 5064.481038470105}, {"lowerIsBetter": false, "replicates": [721.5093736259345, 735.5366119344814, 735.6285076036601, 738.6085374751381, 833.8290650416665, 13671.111377760439, 14008.159510429356, 14023.579292621213, 14070.663286987745, 14071.155730656168, 12979.805302920464, 14570.125792452434, 14585.562433127023, 14673.633159171026, 14709.92645036776, 813.6501304439089, 818.868980963046, 828.2918105020211, 831.3100126894693, 835.6490274084869, 817.7424111404888, 821.876718492225, 822.2229992656942, 822.391430341546, 822.4900561651755, 863.7883718488979, 866.7919699272161, 867.0202670981781, 868.6047848229073, 869.652139144341, 865.3596338709341, 868.700298397052, 868.9261412779858, 876.5135349880813, 882.3029806452895, 638.5306799502362, 638.9041643753428, 639.9136116624243, 642.1555654314561, 644.3620815392775, 14084.0, 14263.85736142646, 14326.856731432656, 14353.282335883268, 14362.784558231635, 11888.108391870644, 11901.761964760657, 11924.284542927453, 12199.268043917393, 12253.081018923616, 10226.386416815016, 10358.119559837423, 10627.84058239127, 10693.0, 10731.678049658523, 3633.7819730816236, 3636.5817930938015, 3640.7087433005295, 3670.5228320318456, 3780.3384407728536, 44583.0, 44738.99999999967, 45176.09647807058, 45219.54780452186, 45327.77336113298, 9530.428174309563, 9548.61805527785, 9579.616815327308, 9735.221182305399, 9953.0, 17669.20488578017, 17709.114544272736, 17770.289188432318, 17772.111394430227, 17774.555636109202, 6896.3103689631635, 6992.2658120897595, 7157.6779044943105, 7160.749373771893, 7384.889226661604, 4162.958370416257, 4219.346001369792, 4256.34026725858, 4260.5952434519295, 4290.163418133497, 2971.1235185620294, 2975.598294230251, 2984.6567644721135, 2985.0746268656353, 2994.5807586937844, 546.573672535423, 562.3701454371048, 565.8104534980745, 566.5863919338823, 568.8720037991419, 559.426587747562, 576.0984059946254, 578.8668606220593, 580.231193668391, 587.2662754875973, 7388.0, 7508.587027713419, 7762.7671169865, 7769.689212431553, 7790.182030886675, 570.1760955419462, 574.2362657665295, 583.2446981159324, 598.4374687793547, 605.2132228103447, 3623.3477973964414, 3711.4247291669294, 3863.4977452931503, 3987.142764305688, 4026.859059932888, 51399.0, 51635.48364516307, 57663.67522435834, 58195.0, 58632.12051819226, 53693.73153134288, 53976.73011634995, 54043.18935215975, 57620.42379576234, 57635.42364576385, 50346.496535034916, 50792.238116428285, 51351.743241283555, 53180.46819531755, 53853.192202117, 7571.167171611009, 7730.18833022547, 7859.882101768364, 7876.0, 8096.0, 33497.16257093495, 33636.49545256774, 34290.314193716484, 34935.0, 35088.47367289544, 43389.0, 44161.0, 45059.77470112628, 45338.546614533436, 45748.771256144835, 10810.783784324427, 10831.837522437327, 10916.890831091587, 11015.394153321644, 11441.0, 11025.889741102486, 11220.719482013015, 11269.605563805228, 11283.040941520063, 11662.241954272946, 10568.0, 10721.463926803473, 10882.075023623082, 11145.415405113967, 11440.48517816717, 10920.0, 11067.72330691739, 11100.777984440427, 11165.16261280391, 11553.729089800283, 10293.176545876162, 10544.683659490227, 10761.838572421577, 10795.514201861091, 11074.11407087415, 9279.39683920543, 9346.672866449642, 9377.953110234404, 9397.718068457958, 9630.951845240728, 8425.410221284452, 8636.27274545081, 8645.438046526955, 9051.14014168653, 9306.441613503212], "unit": "ms", "name": "yui.html", "value": 6197.822814945389}], "name": "dromaeo_css", "value": 7043.561943524663}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 110.0, 111.0, 123.0, 112.0, 112.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 154.0, 172.0, 128.0, 156.0, 151.0, 129.0, 163.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 160.0, 162.0, 163.0, 161.0, 173.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 73.0, 71.0, 71.0, 132.0, 72.0, 71.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 77.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 139.0, 92.0, 93.0, 94.0, 139.0, 93.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 148.0, 147.0, 146.0, 147.0, 145.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 62.0, 63.0, 64.0, 65.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 63.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 94.0, 84.0, 85.0, 88.0, 84.0, 84.0, 90.0, 93.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [120.0, 121.0, 124.0, 118.0, 119.0, 130.0, 126.0, 133.0, 122.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [153.0, 149.0, 149.0, 151.0, 157.0, 141.0, 155.0, 152.0, 142.0, 154.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 71.0, 68.0, 65.0, 67.0, 67.0, 69.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1517.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [184.1959845275373], "unit": "score", "name": "Richards", "value": 191.654558}, {"lowerIsBetter": false, "replicates": [193.87359441644048], "unit": "score", "name": "DeltaBlue", "value": 341.0366439999999}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [4990.049751243781], "unit": "score", "name": "Decrypt", "value": 53.34235393818545}, {"lowerIsBetter": false, "replicates": [1051.5247108307046], "unit": "score", "name": "RayTrace", "value": 703.7295389999999}, {"lowerIsBetter": false, "replicates": [747.9431563201197], "unit": "score", "name": "Earley", "value": 891.0610309999998}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [658.1196581196581], "unit": "score", "name": "Splay", "value": 123.82398701298706}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20926.091080996397}]} 15:49:31 INFO - RETURN: dromaeo_css: 7043.56 15:49:31 INFO - RETURN: kraken: 1517.20 15:49:31 INFO - RETURN: v8_7: 20926.09 15:49:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20926.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7043.56"}}} 15:49:31 INFO - Return code: 0 15:49:31 INFO - # TBPL SUCCESS # 15:49:31 INFO - Running post-action listener: _resource_record_post_action 15:49:31 INFO - Running post-run listener: _resource_record_post_run 15:49:32 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 12288; Write bytes: 527458304; Read time: 260; Write time: 478576 15:49:32 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 142581760; Read time: 0; Write time: 238336 15:49:32 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 357855232; Read time: 168; Write time: 236724 15:49:32 INFO - Running post-run listener: _upload_blobber_files 15:49:32 INFO - Blob upload gear active. 15:49:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:49:32 INFO - Copying logs to upload dir... 15:49:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.258969 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-23 15:49:32.788315) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:32.791731) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010297 build_url: 'https://queue.taskcluster.net/v1/task/os3zFskOQOC_UedCE1KJJQ/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-23 15:49:32.842334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:32.842640) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448320726.755663-1637588172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:49:32.892151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:49:32.892460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:49:32.892736) ========= ========= Total master_lag: 0.27 =========