builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1448107600.62 results: success (0) buildid: 20151121023041 builduid: 2660502593ca4b95b437f4f0d87f4fa5 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:40.620870) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:40.621428) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:40.621706) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006694 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:40.648265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:40.648589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.107583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.107858) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.187674) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.187936) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.190329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.190610) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 04:06:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2015-11-21 04:06:42 (15.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111885 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.343703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.343985) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013363 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.408816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:41.409142) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --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 489332006384610e3322739f66729448da0e98d9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 04:06:42,624 truncating revision to first 12 chars 2015-11-21 04:06:42,624 Setting DEBUG logging. 2015-11-21 04:06:42,624 attempt 1/10 2015-11-21 04:06:42,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 04:06:43,225 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:42.304996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:42.305296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:42.319326) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:42.320232) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 04:06:42.320708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-21 04:06:42.320990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:43 INFO - MultiFileLogger online at 20151121 04:06:43 in /builds/slave/test-pgo 04:06:43 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 04:06:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:06:43 INFO - {'append_to_log': False, 04:06:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:06:43 INFO - 'blob_upload_branch': 'Fx-Team', 04:06:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:06:43 INFO - 'branch': 'Fx-Team', 04:06:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:43 INFO - 'config_files': ('talos/linux_config.py',), 04:06:43 INFO - 'default_actions': ('clobber', 04:06:43 INFO - 'read-buildbot-config', 04:06:43 INFO - 'download-and-extract', 04:06:43 INFO - 'populate-webroot', 04:06:43 INFO - 'create-virtualenv', 04:06:43 INFO - 'install', 04:06:43 INFO - 'run-tests'), 04:06:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:43 INFO - 'download_minidump_stackwalk': True, 04:06:43 INFO - 'download_symbols': 'ondemand', 04:06:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:43 INFO - 'installer_path': 'installer.exe', 04:06:43 INFO - 'log_level': 'info', 04:06:43 INFO - 'log_name': 'talos', 04:06:43 INFO - 'log_to_console': True, 04:06:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:43 INFO - 'opt_config_files': (), 04:06:43 INFO - 'pip_index': False, 04:06:43 INFO - 'sps_profile': False, 04:06:43 INFO - 'sps_profile_interval': 0, 04:06:43 INFO - 'suite': 'dromaeojs-e10s', 04:06:43 INFO - 'system_bits': '64', 04:06:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:43 INFO - 'title': 'talos-linux64-ix-067', 04:06:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:43 INFO - 'use_talos_json': True, 04:06:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:06:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:43 INFO - 'work_dir': 'build'} 04:06:43 INFO - ##### 04:06:43 INFO - ##### Running clobber step. 04:06:43 INFO - ##### 04:06:43 INFO - Running pre-action listener: _resource_record_pre_action 04:06:43 INFO - Running main action method: clobber 04:06:43 INFO - rmtree: /builds/slave/test-pgo/build 04:06:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:06:44 INFO - Running post-action listener: _resource_record_post_action 04:06:44 INFO - ##### 04:06:44 INFO - ##### Running read-buildbot-config step. 04:06:44 INFO - ##### 04:06:44 INFO - Running pre-action listener: _resource_record_pre_action 04:06:44 INFO - Running main action method: read_buildbot_config 04:06:44 INFO - Using buildbot properties: 04:06:44 INFO - { 04:06:44 INFO - "properties": { 04:06:44 INFO - "buildnumber": 350, 04:06:44 INFO - "product": "firefox", 04:06:44 INFO - "script_repo_revision": "production", 04:06:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:06:44 INFO - "repository": "", 04:06:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:06:44 INFO - "buildid": "20151121023041", 04:06:44 INFO - "slavename": "talos-linux64-ix-067", 04:06:44 INFO - "pgo_build": "True", 04:06:44 INFO - "basedir": "/builds/slave/test-pgo", 04:06:44 INFO - "project": "", 04:06:44 INFO - "platform": "ubuntu64_hw", 04:06:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:06:44 INFO - "slavebuilddir": "test", 04:06:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:06:44 INFO - "branch": "fx-team", 04:06:44 INFO - "repo_path": "integration/fx-team", 04:06:44 INFO - "stage_platform": "linux64-pgo", 04:06:44 INFO - "builduid": "2660502593ca4b95b437f4f0d87f4fa5", 04:06:44 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 04:06:44 INFO - }, 04:06:44 INFO - "sourcestamp": { 04:06:44 INFO - "repository": "", 04:06:44 INFO - "hasPatch": false, 04:06:44 INFO - "project": "", 04:06:44 INFO - "branch": "fx-team-linux64-pgo-talos", 04:06:44 INFO - "changes": [ 04:06:44 INFO - { 04:06:44 INFO - "category": null, 04:06:44 INFO - "files": [ 04:06:44 INFO - { 04:06:44 INFO - "url": null, 04:06:44 INFO - "name": "https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:06:44 INFO - } 04:06:44 INFO - ], 04:06:44 INFO - "repository": "", 04:06:44 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 04:06:44 INFO - "who": "sendchange", 04:06:44 INFO - "when": 1448107546, 04:06:44 INFO - "number": 6692256, 04:06:44 INFO - "comments": "", 04:06:44 INFO - "project": "", 04:06:44 INFO - "at": "Sat 21 Nov 2015 04:05:46", 04:06:44 INFO - "branch": "fx-team-linux64-pgo-talos", 04:06:44 INFO - "revlink": "", 04:06:44 INFO - "properties": [ 04:06:44 INFO - [ 04:06:44 INFO - "buildid", 04:06:44 INFO - "20151121023041", 04:06:44 INFO - "Change" 04:06:44 INFO - ], 04:06:44 INFO - [ 04:06:44 INFO - "builduid", 04:06:44 INFO - "2660502593ca4b95b437f4f0d87f4fa5", 04:06:44 INFO - "Change" 04:06:44 INFO - ], 04:06:44 INFO - [ 04:06:44 INFO - "pgo_build", 04:06:44 INFO - "True", 04:06:44 INFO - "Change" 04:06:44 INFO - ] 04:06:44 INFO - ], 04:06:44 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 04:06:44 INFO - } 04:06:44 INFO - ], 04:06:44 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 04:06:44 INFO - } 04:06:44 INFO - } 04:06:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:06:44 INFO - Running post-action listener: _resource_record_post_action 04:06:44 INFO - ##### 04:06:44 INFO - ##### Running download-and-extract step. 04:06:44 INFO - ##### 04:06:44 INFO - Running pre-action listener: _resource_record_pre_action 04:06:44 INFO - Running main action method: download_and_extract 04:06:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:06: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')]} 04:06:44 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json 04:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json 04:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:06:50 INFO - Downloaded 1302 bytes. 04:06:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:06:50 INFO - Using the following test package requirements: 04:06:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'jsshell-linux-x86_64.zip'], 04:06:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:06:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:06:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:50 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:01 INFO - Downloaded 22523697 bytes. 04:07:01 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 04:07:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:01 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 04:07:02 INFO - Return code: 0 04:07:02 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 04:07:02 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')]} 04:07:02 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:03 INFO - Downloaded 22523697 bytes. 04:07:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:07:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:07:05 INFO - Return code: 0 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:06 INFO - Downloaded 11130997 bytes. 04:07:06 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 04:07:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:07:06 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 04:07:06 INFO - Return code: 0 04:07:06 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')]} 04:07:06 INFO - https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_LjMqi_cQG6SVypm14JQiQ/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 04:07:08 INFO - Downloaded 57431663 bytes. 04:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:08 INFO - mkdir: /builds/slave/test-pgo/properties 04:07:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:07:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:07:08 INFO - Contents: 04:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:07:08 INFO - Running post-action listener: _resource_record_post_action 04:07:08 INFO - Running post-action listener: set_extra_try_arguments 04:07:08 INFO - ##### 04:07:08 INFO - ##### Running populate-webroot step. 04:07:08 INFO - ##### 04:07:08 INFO - Running pre-action listener: _resource_record_pre_action 04:07:08 INFO - Running main action method: populate_webroot 04:07:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:07:08 INFO - '../fennec_ids.txt'], 04:07:08 INFO - 'tests': ['tcheck2']}, 04:07:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:08 INFO - '--tppagecycles', 04:07:08 INFO - '7'], 04:07:08 INFO - 'tests': ['tsvgm']}}, 04:07:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:07:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:07:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:07:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'tests': ['damp', 'tps']}, 04:07:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['damp', 'tps']}, 04:07:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:07:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:08 INFO - 'other': {'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore']}, 04:07:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore']}, 04:07:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore']}, 04:07:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore']}, 04:07:08 INFO - 'other_l64': {'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore']}, 04:07:08 INFO - 'other_nol64': {'tests': ['a11yr', 04:07:08 INFO - 'ts_paint', 04:07:08 INFO - 'tpaint', 04:07:08 INFO - 'sessionrestore', 04:07:08 INFO - 'sessionrestore_no_auto_restore']}, 04:07:08 INFO - 'svgr': {'tests': ['tsvgx', 04:07:08 INFO - 'tsvgr_opacity', 04:07:08 INFO - 'tart', 04:07:08 INFO - 'tscrollx', 04:07:08 INFO - 'cart']}, 04:07:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['tsvgx', 04:07:08 INFO - 'tsvgr_opacity', 04:07:08 INFO - 'tart', 04:07:08 INFO - 'tscrollx', 04:07:08 INFO - 'cart']}, 04:07:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'tests': ['tp5o']}, 04:07:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--e10s'], 04:07:08 INFO - 'tests': ['tp5o']}, 04:07:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--xperf_path', 04:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:08 INFO - 'tests': ['tp5n']}, 04:07:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:08 INFO - 'talos_options': ['--e10s', 04:07:08 INFO - '--xperf_path', 04:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:08 INFO - 'tests': ['tp5n']}}, 04:07:08 INFO - 'talos.zip': {'path': '', 04:07:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:08 INFO - Running post-action listener: _resource_record_post_action 04:07:08 INFO - ##### 04:07:08 INFO - ##### Running create-virtualenv step. 04:07:08 INFO - ##### 04:07:08 INFO - Running pre-action listener: _resource_record_pre_action 04:07:08 INFO - Running main action method: create_virtualenv 04:07:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:07:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:07:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:07:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:08 INFO - Using real prefix '/usr' 04:07:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:07:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:10 INFO - Installing pip.................done. 04:07:10 INFO - Return code: 0 04:07:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:07:10 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')]} 04:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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')]} 04:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:10 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 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:10 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 04:07:10 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 04:07:10 INFO - Using env: {'DISPLAY': ':0', 04:07:10 INFO - 'HOME': '/home/cltbld', 04:07:10 INFO - 'LANG': 'en_US.UTF-8', 04:07:10 INFO - 'LANGUAGE': 'en_US:en', 04:07:10 INFO - 'LOGNAME': 'cltbld', 04:07:10 INFO - 'MAIL': '/var/mail/cltbld', 04:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:10 INFO - 'MOZ_NO_REMOTE': '1', 04:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:10 INFO - 'NO_EM_RESTART': '1', 04:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:10 INFO - 'SHELL': '/bin/bash', 04:07:10 INFO - 'SHLVL': '1', 04:07:10 INFO - 'TERM': 'linux', 04:07:10 INFO - 'TMOUT': '86400', 04:07:10 INFO - 'USER': 'cltbld', 04:07:10 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:10 INFO - '_': '/tools/buildbot/bin/python'} 04:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:07:11 INFO - Cleaning up... 04:07:11 INFO - Return code: 0 04:07:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:07:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:07:11 INFO - Using env: {'DISPLAY': ':0', 04:07:11 INFO - 'HOME': '/home/cltbld', 04:07:11 INFO - 'LANG': 'en_US.UTF-8', 04:07:11 INFO - 'LANGUAGE': 'en_US:en', 04:07:11 INFO - 'LOGNAME': 'cltbld', 04:07:11 INFO - 'MAIL': '/var/mail/cltbld', 04:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:11 INFO - 'MOZ_NO_REMOTE': '1', 04:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:11 INFO - 'NO_EM_RESTART': '1', 04:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:11 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:11 INFO - 'SHELL': '/bin/bash', 04:07:11 INFO - 'SHLVL': '1', 04:07:11 INFO - 'TERM': 'linux', 04:07:11 INFO - 'TMOUT': '86400', 04:07:11 INFO - 'USER': 'cltbld', 04:07:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:11 INFO - '_': '/tools/buildbot/bin/python'} 04:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:11 INFO - Downloading/unpacking psutil>=0.7.1 04:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:07:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:13 INFO - Installing collected packages: psutil 04:07:13 INFO - Running setup.py install for psutil 04:07:13 INFO - building 'psutil._psutil_linux' extension 04:07:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:07:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:07:13 INFO - building 'psutil._psutil_posix' extension 04:07:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:07:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:13 INFO - Successfully installed psutil 04:07:13 INFO - Cleaning up... 04:07:13 INFO - Return code: 0 04:07:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:07:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:07:13 INFO - Using env: {'DISPLAY': ':0', 04:07:13 INFO - 'HOME': '/home/cltbld', 04:07:13 INFO - 'LANG': 'en_US.UTF-8', 04:07:13 INFO - 'LANGUAGE': 'en_US:en', 04:07:13 INFO - 'LOGNAME': 'cltbld', 04:07:13 INFO - 'MAIL': '/var/mail/cltbld', 04:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:13 INFO - 'MOZ_NO_REMOTE': '1', 04:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:13 INFO - 'NO_EM_RESTART': '1', 04:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:13 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:13 INFO - 'SHELL': '/bin/bash', 04:07:13 INFO - 'SHLVL': '1', 04:07:13 INFO - 'TERM': 'linux', 04:07:13 INFO - 'TMOUT': '86400', 04:07:13 INFO - 'USER': 'cltbld', 04:07:13 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:13 INFO - '_': '/tools/buildbot/bin/python'} 04:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07:13 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 04:07:13 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 04:07:13 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 04:07:13 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 04:07:13 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 04:07:13 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 04:07:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:07:15 INFO - Installing collected packages: mozsystemmonitor 04:07:15 INFO - Running setup.py install for mozsystemmonitor 04:07:15 INFO - Successfully installed mozsystemmonitor 04:07:15 INFO - Cleaning up... 04:07:15 INFO - Return code: 0 04:07:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:07:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:15 INFO - Using env: {'DISPLAY': ':0', 04:07:15 INFO - 'HOME': '/home/cltbld', 04:07:15 INFO - 'LANG': 'en_US.UTF-8', 04:07:15 INFO - 'LANGUAGE': 'en_US:en', 04:07:15 INFO - 'LOGNAME': 'cltbld', 04:07:15 INFO - 'MAIL': '/var/mail/cltbld', 04:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:15 INFO - 'MOZ_NO_REMOTE': '1', 04:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:15 INFO - 'NO_EM_RESTART': '1', 04:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:15 INFO - 'SHELL': '/bin/bash', 04:07:15 INFO - 'SHLVL': '1', 04:07:15 INFO - 'TERM': 'linux', 04:07:15 INFO - 'TMOUT': '86400', 04:07:15 INFO - 'USER': 'cltbld', 04:07:15 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:15 INFO - '_': '/tools/buildbot/bin/python'} 04:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:15 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 04:07:15 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 04:07:15 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 04:07:15 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 04:07:15 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 04:07:15 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 04:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - Downloading docopt-0.6.1.tar.gz 04:07:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:18 INFO - Running setup.py install for blobuploader 04:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:07:18 INFO - Running setup.py install for requests 04:07:18 INFO - Running setup.py install for docopt 04:07:19 INFO - Successfully installed blobuploader requests docopt 04:07:19 INFO - Cleaning up... 04:07:19 INFO - Return code: 0 04:07:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:19 INFO - Using env: {'DISPLAY': ':0', 04:07:19 INFO - 'HOME': '/home/cltbld', 04:07:19 INFO - 'LANG': 'en_US.UTF-8', 04:07:19 INFO - 'LANGUAGE': 'en_US:en', 04:07:19 INFO - 'LOGNAME': 'cltbld', 04:07:19 INFO - 'MAIL': '/var/mail/cltbld', 04:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:19 INFO - 'MOZ_NO_REMOTE': '1', 04:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:19 INFO - 'NO_EM_RESTART': '1', 04:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:19 INFO - 'SHELL': '/bin/bash', 04:07:19 INFO - 'SHLVL': '1', 04:07:19 INFO - 'TERM': 'linux', 04:07:19 INFO - 'TMOUT': '86400', 04:07:19 INFO - 'USER': 'cltbld', 04:07:19 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:19 INFO - '_': '/tools/buildbot/bin/python'} 04:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:19 INFO - Running setup.py (path:/tmp/pip-jfkjsq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:19 INFO - Running setup.py (path:/tmp/pip-WkAKJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:19 INFO - Running setup.py (path:/tmp/pip-1AJxZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:19 INFO - Running setup.py (path:/tmp/pip-rPhbvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:19 INFO - Running setup.py (path:/tmp/pip-CzM66u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:19 INFO - Running setup.py (path:/tmp/pip-XLUNqY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:19 INFO - Running setup.py (path:/tmp/pip-9cAs4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:19 INFO - Running setup.py (path:/tmp/pip-OBIGm3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:19 INFO - Running setup.py (path:/tmp/pip-aeGOj2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:19 INFO - Running setup.py (path:/tmp/pip-Vwu9zK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:20 INFO - Running setup.py (path:/tmp/pip-5QV9MH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:20 INFO - Running setup.py (path:/tmp/pip-6GPv4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:20 INFO - Running setup.py (path:/tmp/pip-sWpe3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:20 INFO - Running setup.py (path:/tmp/pip-8hSIj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:20 INFO - Running setup.py (path:/tmp/pip-PbPG8u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:20 INFO - Running setup.py (path:/tmp/pip-26Az7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:20 INFO - Running setup.py (path:/tmp/pip-46aSNQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:20 INFO - Running setup.py install for manifestparser 04:07:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:07:20 INFO - Running setup.py install for mozcrash 04:07:20 INFO - Running setup.py install for mozdebug 04:07:20 INFO - Running setup.py install for mozdevice 04:07:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:07:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:07:20 INFO - Running setup.py install for mozfile 04:07:21 INFO - Running setup.py install for mozhttpd 04:07:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for mozinfo 04:07:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for mozInstall 04:07:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for mozleak 04:07:21 INFO - Running setup.py install for mozlog 04:07:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for moznetwork 04:07:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for mozprocess 04:07:21 INFO - Running setup.py install for mozprofile 04:07:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:07:21 INFO - Running setup.py install for mozrunner 04:07:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Running setup.py install for mozscreenshot 04:07:22 INFO - Running setup.py install for moztest 04:07:22 INFO - Running setup.py install for mozversion 04:07:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:07:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:22 INFO - Cleaning up... 04:07:22 INFO - Return code: 0 04:07:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:07:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:22 INFO - Using env: {'DISPLAY': ':0', 04:07:22 INFO - 'HOME': '/home/cltbld', 04:07:22 INFO - 'LANG': 'en_US.UTF-8', 04:07:22 INFO - 'LANGUAGE': 'en_US:en', 04:07:22 INFO - 'LOGNAME': 'cltbld', 04:07:22 INFO - 'MAIL': '/var/mail/cltbld', 04:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:22 INFO - 'MOZ_NO_REMOTE': '1', 04:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:22 INFO - 'NO_EM_RESTART': '1', 04:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:22 INFO - 'SHELL': '/bin/bash', 04:07:22 INFO - 'SHLVL': '1', 04:07:22 INFO - 'TERM': 'linux', 04:07:22 INFO - 'TMOUT': '86400', 04:07:22 INFO - 'USER': 'cltbld', 04:07:22 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:22 INFO - '_': '/tools/buildbot/bin/python'} 04:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:22 INFO - Running setup.py (path:/tmp/pip-GAIv3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:22 INFO - Running setup.py (path:/tmp/pip-OLJ1X4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:22 INFO - Running setup.py (path:/tmp/pip-T9G_jg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:22 INFO - Running setup.py (path:/tmp/pip-9Cd5Qr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:22 INFO - Running setup.py (path:/tmp/pip-krNdjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:22 INFO - Running setup.py (path:/tmp/pip-b8WvVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:07:23 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)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:23 INFO - Running setup.py (path:/tmp/pip-kbahfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:07:23 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)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:23 INFO - Running setup.py (path:/tmp/pip-PmJo6R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:23 INFO - Running setup.py (path:/tmp/pip-5bwrrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:23 INFO - Running setup.py (path:/tmp/pip-De_lw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:23 INFO - Running setup.py (path:/tmp/pip-UeKZWq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:23 INFO - Running setup.py (path:/tmp/pip-p5lPr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:23 INFO - Running setup.py (path:/tmp/pip-jj4lNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:23 INFO - Running setup.py (path:/tmp/pip-QH9HJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:23 INFO - Running setup.py (path:/tmp/pip-EivWam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:23 INFO - Running setup.py (path:/tmp/pip-21Ffp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:23 INFO - Running setup.py (path:/tmp/pip-URGtYk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:07:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:25 INFO - Downloading blessings-1.5.1.tar.gz 04:07:25 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:07:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:25 INFO - Installing collected packages: blessings 04:07:25 INFO - Running setup.py install for blessings 04:07:25 INFO - Successfully installed blessings 04:07:25 INFO - Cleaning up... 04:07:25 INFO - Return code: 0 04:07:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:07:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:07:25 INFO - Reading from file tmpfile_stdout 04:07:25 INFO - Current package versions: 04:07:25 INFO - argparse == 1.2.1 04:07:25 INFO - blessings == 1.5.1 04:07:25 INFO - blobuploader == 1.2.4 04:07:25 INFO - docopt == 0.6.1 04:07:25 INFO - manifestparser == 1.1 04:07:25 INFO - mozInstall == 1.12 04:07:25 INFO - mozcrash == 0.16 04:07:25 INFO - mozdebug == 0.1 04:07:25 INFO - mozdevice == 0.47 04:07:25 INFO - mozfile == 1.2 04:07:25 INFO - mozhttpd == 0.7 04:07:25 INFO - mozinfo == 0.9 04:07:25 INFO - mozleak == 0.1 04:07:25 INFO - mozlog == 3.0 04:07:25 INFO - moznetwork == 0.27 04:07:25 INFO - mozprocess == 0.22 04:07:25 INFO - mozprofile == 0.27 04:07:25 INFO - mozrunner == 6.11 04:07:25 INFO - mozscreenshot == 0.1 04:07:25 INFO - mozsystemmonitor == 0.0 04:07:25 INFO - moztest == 0.7 04:07:25 INFO - mozversion == 1.4 04:07:25 INFO - psutil == 3.1.1 04:07:25 INFO - requests == 1.2.3 04:07:25 INFO - wsgiref == 0.1.2 04:07:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3037446c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b446c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf67c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', '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 04:07:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:07:25 INFO - Using env: {'DISPLAY': ':0', 04:07:25 INFO - 'HOME': '/home/cltbld', 04:07:25 INFO - 'LANG': 'en_US.UTF-8', 04:07:25 INFO - 'LANGUAGE': 'en_US:en', 04:07:25 INFO - 'LOGNAME': 'cltbld', 04:07:25 INFO - 'MAIL': '/var/mail/cltbld', 04:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:25 INFO - 'MOZ_NO_REMOTE': '1', 04:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:25 INFO - 'NO_EM_RESTART': '1', 04:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:25 INFO - 'SHELL': '/bin/bash', 04:07:25 INFO - 'SHLVL': '1', 04:07:25 INFO - 'TERM': 'linux', 04:07:25 INFO - 'TMOUT': '86400', 04:07:25 INFO - 'USER': 'cltbld', 04:07:25 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:25 INFO - '_': '/tools/buildbot/bin/python'} 04:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:07:26 INFO - Cleaning up... 04:07:26 INFO - Return code: 0 04:07:26 INFO - Running post-action listener: _resource_record_post_action 04:07:26 INFO - Running post-action listener: _start_resource_monitoring 04:07:26 INFO - Starting resource monitoring. 04:07:26 INFO - ##### 04:07:26 INFO - ##### Running install step. 04:07:26 INFO - ##### 04:07:26 INFO - Running pre-action listener: _resource_record_pre_action 04:07:26 INFO - Running main action method: install 04:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:07:26 INFO - Reading from file tmpfile_stdout 04:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:07:26 INFO - Reading from file tmpfile_stdout 04:07:26 INFO - Output received: 04:07:26 INFO - Usage: mozinstall [options] installer 04:07:26 INFO - Options: 04:07:26 INFO - -h, --help show this help message and exit 04:07:26 INFO - -d DEST, --destination=DEST 04:07:26 INFO - Directory to install application into. [default: 04:07:26 INFO - "/builds/slave/test-pgo"] 04:07:26 INFO - --app=APP Application being installed. [default: firefox] 04:07:26 INFO - mkdir: /builds/slave/test-pgo/build/application 04:07:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:07:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:07:40 INFO - Reading from file tmpfile_stdout 04:07:40 INFO - Output received: 04:07:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:07:40 INFO - Running post-action listener: _resource_record_post_action 04:07:40 INFO - ##### 04:07:40 INFO - ##### Running run-tests step. 04:07:40 INFO - ##### 04:07:40 INFO - Running pre-action listener: _resource_record_pre_action 04:07:40 INFO - Running main action method: run_tests 04:07:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:07:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:07:40 INFO - Python 2.7.3 04:07:40 INFO - Return code: 0 04:07:40 INFO - grabbing minidump binary from tooltool 04:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3ad70>, '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 0x1c3bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bfb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:07:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:07:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:07:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:40 INFO - Return code: 0 04:07:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:07:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:07:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:07:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:07:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:07:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:07:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 04:07:40 INFO - Using env: {'DISPLAY': ':0', 04:07:40 INFO - 'HOME': '/home/cltbld', 04:07:40 INFO - 'LANG': 'en_US.UTF-8', 04:07:40 INFO - 'LANGUAGE': 'en_US:en', 04:07:40 INFO - 'LOGNAME': 'cltbld', 04:07:40 INFO - 'MAIL': '/var/mail/cltbld', 04:07:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:07:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:40 INFO - 'MOZ_NO_REMOTE': '1', 04:07:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:40 INFO - 'NO_EM_RESTART': '1', 04:07:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:07:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:07:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:07:40 INFO - 'SHELL': '/bin/bash', 04:07:40 INFO - 'SHLVL': '1', 04:07:40 INFO - 'TERM': 'linux', 04:07:40 INFO - 'TMOUT': '86400', 04:07:40 INFO - 'USER': 'cltbld', 04:07:40 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540', 04:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:40 INFO - '_': '/tools/buildbot/bin/python'} 04:07:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 04:07:41 INFO - mozversion INFO | application_buildid: 20151121023041 04:07:41 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 04:07:41 INFO - mozversion INFO | application_display_name: Nightly 04:07:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:41 INFO - mozversion INFO | application_name: Firefox 04:07:41 INFO - mozversion INFO | application_remotingname: firefox 04:07:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:07:41 INFO - mozversion INFO | application_vendor: Mozilla 04:07:41 INFO - mozversion INFO | application_version: 45.0a1 04:07:41 INFO - mozversion INFO | platform_buildid: 20151121023041 04:07:41 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 04:07:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:07:41 INFO - mozversion INFO | platform_version: 45.0a1 04:07:41 INFO - 2015-11-21 04:07:41,184 DEBUG : using testdate: 1448107661 04:07:41 INFO - 2015-11-21 04:07:41,184 DEBUG : actual date: 1448107661 04:07:41 INFO - 2015-11-21 04:07:41,231 INFO : starting webserver on 'localhost:44263' 04:07:41 INFO - 2015-11-21 04:07:41,232 INFO : Starting test suite talos-linux64-ix-067.e 04:07:41 INFO - 2015-11-21 04:07:41,232 INFO : Starting test dromaeo_css 04:07:41 INFO - 2015-11-21 04:07:41,233 DEBUG : operating with platform_type : linux_ 04:07:41 INFO - 2015-11-21 04:07:41,233 INFO : Initialising browser for dromaeo_css test... 04:07:41 INFO - 2015-11-21 04:07:41,250 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjbNo8T/profile http://localhost:44263/getInfo.html 04:07:45 INFO - 2015-11-21 04:07:45,952 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:45 INFO - 2015-11-21 04:07:45,952 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:45 INFO - 2015-11-21 04:07:45,952 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:45 INFO - 2015-11-21 04:07:45,952 DEBUG : BROWSER_OUTPUT: __metrics 04:07:47 INFO - 2015-11-21 04:07:47,007 INFO : Browser initialized. 04:07:47 INFO - 2015-11-21 04:07:47,007 INFO : Running cycle 1/1 for dromaeo_css test... 04:07:47 INFO - 2015-11-21 04:07:47,008 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjbNo8T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:58 INFO - 2015-11-21 04:07:58,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 142245888 04:07:58 INFO - 2015-11-21 04:07:58,777 DEBUG : BROWSER_OUTPUT: 04:08:48 INFO - 2015-11-21 04:08:48,419 DEBUG : BROWSER_OUTPUT: 1448107728416 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] 04:10:57 INFO - 2015-11-21 04:10:57,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44263/tests/dromaeo/cssquery-ext.html) 04:10:58 INFO - 2015-11-21 04:10:58,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 146636800 04:10:58 INFO - 2015-11-21 04:10:58,702 DEBUG : BROWSER_OUTPUT: 04:14:00 INFO - 2015-11-21 04:14:00,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-ext.html (next: http://localhost:44263/tests/dromaeo/cssquery-jquery.html) 04:14:01 INFO - 2015-11-21 04:14:01,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 141152256 04:14:01 INFO - 2015-11-21 04:14:01,383 DEBUG : BROWSER_OUTPUT: 04:17:03 INFO - 2015-11-21 04:17:03,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44263/tests/dromaeo/cssquery-mootools.html) 04:17:03 INFO - 2015-11-21 04:17:03,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 04:17:03 INFO - 2015-11-21 04:17:03,647 DEBUG : BROWSER_OUTPUT: 04:20:05 INFO - 2015-11-21 04:20:05,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44263/tests/dromaeo/cssquery-prototype.html) 04:20:05 INFO - 2015-11-21 04:20:05,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 140996608 04:20:05 INFO - 2015-11-21 04:20:05,934 DEBUG : BROWSER_OUTPUT: 04:23:08 INFO - 2015-11-21 04:23:08,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44263/tests/dromaeo/cssquery-yui.html) 04:23:08 INFO - 2015-11-21 04:23:08,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 141193216 04:23:08 INFO - 2015-11-21 04:23:08,830 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-yui.html (next: http://localhost:44263/tests/dromaeo/cssquery-dojo.html) 04:26:11 INFO - 2015-11-21 04:26:11,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 144465920 04:26:11 INFO - 2015-11-21 04:26:11,529 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,529 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:26:11 INFO - 2015-11-21 04:26:11,529 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:26:11 INFO - 2015-11-21 04:26:11,530 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:26:11 INFO - 2015-11-21 04:26:11,530 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:26:11 INFO - 2015-11-21 04:26:11,530 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3234.7897386669865;3260.6902344277287;3289.983550082249;3311.0894504011394;3314.7679662423625;5227.503387178222;5461.453854614537;5470.179473079035;5476.3702174249975;5492.203630473579;5382.9730851345685;5395.082835917893;5475.151351540508;5554.1113421852515;5588.161775733642;5031.295618613397;5096.770645320969;5154.974225128888;5176.55999240065;5179.2749015137915;4938.1111399947995;5006.774695138727;5046.495350464943;5100.923486147711;5191.402988656297;4892.119418504668;4985.501449855022;4990.126727822653;5068.594512439015;5105.693658380491;5006.524380183877;5018.2974383586325;5021.497850214986;5065.594752419797;5088.0078384715;4999.475055119196;5005.57452616528;5012.649114561982;5035.92446113305;5046.394432668103;5323.467653234646;5329.600279979017;5333.226682131108;5334.706591137486;5336.332958380202;5745.942540574624;5867;5883.146943693183;6002.699865006776;6009.549283803733;6043.909341359883;6054.939450605526;6059.909101363483;6066.181065556138;6076.392360763933;5620.297462817148;5620.662760234399;5624.903143886943;5631.690257035862;5636.928983493205;5786.132080187921;5852.648841069465;6030.276366836008;6103.640733310809;6110.984061328612;5849.473547380756;5897.67562784051;5905.498032667271;5910.586258961831;5940.46535811779;5792.88414231713;5923.49650279731;5975;5975.312839023481;5988.850278742979;5840.328362238312;5850.3564607893095;5911.261092363455;5950.018246989285;5983.551233657493;5932.7330270137945;5957.434043765836;5959.821205363846;5960.195373624505;5960.314563825129;4429.512753597101;4570.4972453030805;4579.061292435043;4584.243599805995;4622.098690755338;4012.518497780285;4022.3363145080734;4046.3121269384274;4073.06319546506;4083.1017176221185;5644.238027866268;5698.1452782083015;5716.1997320375185;5724.627899186539;5725.398833122462;5759.740811663485;5873.20711703923;5999.880002399927;6084.239470066242;6095.177151084636;5677;5731.168980497804;5754.769809207585;5755.366909639936;5802.564807639444;5088.1350170471105;5135.948640513622;5142.922856157161;5156.329677142023;5174.611904107207;5776.306843178845;6022.879542409128;6093.116498107838;6149.200603921461;6167.167432396659;5950.464458198783;5988.790392336247;5990.820275391745;6051.3948605140895;6076.118962750465;6087.269527656709;6102.298235702951;6106.664133472702;6133.53998450127;6179.5056395489155;5767.192593036894;5851.093080572518;5856.560757943086;5864.589478736448;5903.0555111182;5913.5564832636865;5975.462208401264;5990.550708696952;6048.84877878039;6081.148639190428;5828.0966450200285;5833.241678581757;5846.123081537633;5858.677772722541;5859.882802343844;5582.413846546055;5705.486506214461;5737.512311453574;5818.650880947157;5823.7379317931645;5605.075162598126;5684.9431505684415;5687.800926967537;5695.715214239189;5753.539716822728;5874.206982057539;5888.735006924784;5917.881642367042;5951.137085122719;5956.731947062306;5657.264555607745;5720.056190728483;5756.0502517084215;5756.68338241384;5826.41735826414 04:26:11 INFO - 2015-11-21 04:26:11,531 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.3349314794838;580.5239703443176;590.1089355073838;607.2652090969929;609.6616377910264;36423.635763642356;36999.260014799685;37309;37330.81334593327;37337;39230.41154382686;39638.40542391859;39662.43038126568;39666.603333966654;39668.40497392534;8666.090060543647;8750.956245218797;8785.38502304839;8811.647534098629;8846.601902914352;8607.655693772242;8693.782655433633;8733.563321833883;8746.387752857303;8750;8685;8686.131386861294;8688.695895643654;8691.826163476726;8721;8641.611127499245;8652.091530389313;8669.219770220647;8724.040355560883;8746.693865714702;8501.914980850173;8639.697610583662;8650.524221167832;8672.783180420476;8673.349498787617;39300.6594439473;39805.60194398077;39833.20333593341;39875.20249595021;39984;2945.911622651324;3133.7649676274373;3236.6277878044093;3357.446021406465;3826.7512611680154;28953.565696514568;28989;29387.853060734775;29455.852720736475;30408;3865.845366185349;3865.8453661853773;3888.3972984187494;3943.4873466449176;4033.193361327717;265023;267456;268294;271436;279168;43844.342334865;66505.66747166234;68706.65646671735;68707.31292687109;68782.65608671925;60598.394016060156;60891;61085.38914610797;61238.957519885786;61246.77506449935;13589.59231223045;13679.726405472034;13715.657108572366;13773.449062037405;13876.930615346859;9868.901310986941;9881.357711748713;9918.752031199278;10011.599536018623;10029.949850250701;19951.401457956286;19976.700349494768;20076.297329593395;20267.59464810725;20315.492112697302;7613.961930190424;7829.804254893673;7874.173211812677;7901.723439679584;7991.800204994922;844.9493030418195;866.9696560620474;891.7503099132254;928.8281667891462;1104.3373975614568;28043.579346309823;28228.71771282302;28340.291492712848;28468;28694;943.3490891284991;946.8248374050822;965.1988849255101;977.6089564174245;989.1048601016092;14171.149731016172;14655.340509676877;16535.338586456648;16975.40586079506;17112.914435427992;354870;354925;355695;355723;357856;53964.460355395946;54713.452865471634;54782.178267326024;54788.45211547913;54894.451055489735;1236.3323805145121;1258.5217617305366;1264.3046324521476;1264.3235868810143;1429.2067902314107;29344.853275733483;30263.09210723682;32223.194420139684;32617.08594968619;33071.66928330686;48843.75578122087;49532.50467495279;49568.786653133444;49651.25523117084;49699.254511183084;280362;282369;282789;282909;283018;42361.15277694367;42734.14531709411;42801;42920.283188673355;43290.78354608333;48597.5140248593;50112;50639.49360506495;51219.48780512147;51312.74343628258;41089.38365924573;42362.788186058875;42534.361984570874;43041.13917721566;43448;36869.81565092158;37000.25999480049;37036;37044.814775925945;37184.44223336598;40319.193616126926;40536.59463405328;40682.9829254271;41071;41287.1742565153;30741.53887691731;31196.532052018785;33005.17487062843;33618;35583.39874705593;25857.09500167485;26504.734952650226;26754.46491070129;27855.442891141658;28405.715942840307 04:26:11 INFO - 2015-11-21 04:26:11,531 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.7126827269913;355.5608823103468;360.2237178879514;361.89143257022886;365.0708945733109;16559.834401655993;16898.66202675946;17382.652346953055;17520.211590478426;17990.370337038206;14161.291935403215;15682.294296756645;16225.918870405632;16800.663986720258;16944.23750931208;4828.541288577589;4885.218365061591;4916.926246106311;4946.629002824785;4948.134076536609;4851.878703032435;4864.367632207808;4877.122118018755;4898;4927.211646136619;5004.424491183524;5151.793928242866;5190.688558686472;5301.125314323132;5314.441983591725;5205.219217117444;5216.374035115791;5219.921701174486;5225.242339860737;5563.415841336682;5061.721605311706;5062.139436295838;5064.797408103708;5086.949130508685;5095.668781529189;18214.817851821444;18542.721859172125;18571.44285671432;18626.90686546572;18830.435086947415;2029.6549586570318;2058.6603210470253;2075.1180748182114;2118.2797848731507;2174.08688350893;9554;9678.27412944032;11248;12163.635090947286;13200.73598528024;1576.3930886608623;1585.112337091221;1599.3043026283603;1625.6911186874574;1629.6170399956002;57234.427655723324;61405.69297153486;62167.689161553906;62454.37545624531;62628;9937.80124397508;10113.292069555207;10291.485425728684;10451.902550232267;10478.895211047944;12628.368581570885;12702.80945785814;12703.364831758376;12711.237325760483;12790.744185116246;6641.535092543476;6824.41992430639;6909.205441374306;7051.1186101737285;7098.3256590623805;6025.126356678257;6047.78832740852;6356.586821856565;6546.70539825709;6586.571872828346;4235.788210589458;4348.782560872007;4525.7510836904285;4540.636749060067;4562.680612357103;1835.2750663488114;1856.7214917762174;1925.894075825843;1934.071645610087;1947.8344340730914;806.0931452116369;813.7454592309612;823.625250511016;842.3850589070013;855.482433127961;16288.837111628969;16426;16491.257893394824;16769.32922683079;16956;882.5057967538199;897.6274845938992;906.9796478961168;914.2822884036;919.4078457460027;9280.118388753057;9386.718398447922;9497.810043799085;9542.666006689733;9658.227341812639;497691;501185;503769;521906;522614;76194;77461;78128.2187178121;78132.21867781249;78937.21062789414;1068.3056013591229;1072.3030030480095;1076.1068313299943;1078.5793540519203;1085.9674209773718;14163.787543186654;14337.78493322622;14441.711165776836;14472.565823025327;15406.383744650537;33476.66523334833;33823.83088084544;34252.65747342594;34897.65102348944;35021.47467787934;42934.35598466088;44233.77883110692;45604.31593526033;45607;45966;9166;9603.471809050568;9623.374480658735;9658.468784216935;9736;11123.66629001099;11133.554657813596;11203.775924481628;11249.381284029458;12555.448986931862;13089.541866034642;13320.267385293902;13436.731265374834;13530.526431574848;13791.51729689456;14148.929255354069;14224.530300995244;14442.277886105863;14665.48670796517;14976.400943962119;13868.306584670525;14009.159450433006;14298.28508574588;14455.49405770793;14589.416423342947;9038.141376569216;9157.908420915972;9468.248374050823;9591.472469014272;9832.557534910804;9984.301098923297;10091.949540252252;13862.65343366424;13870.72258554803;13982.161070335813 04:26:11 INFO - 2015-11-21 04:26:11,532 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1464.54599074287;1528.816542014958;1586.698527279816;1679.8740094492916;1791.7222830461283;7343.4492413068965;7656.349210317129;7837.725679601215;7861.921380786183;7870.803229919247;7828.138904720477;7901;7920.089189743181;7966.681332746698;8025.3178479829285;2293.4495721027;2313.4794671199015;2318.8840557972035;2332.54515369503;2333.614953532665;2268.2061278552455;2300.723913130427;2305.2738387408;2307.5500277445904;2308.4921317310163;2248.3704562722464;2284.6116160252795;2318.686977258074;2324.035525257025;2326.0579465316573;2261.705978222837;2304.1820153845397;2343.9765602343928;2345.4839935214227;2348.6829278047417;2299.356180269527;2358.056777289098;2370.5969985102574;2372.240882917467;2372.466195106105;7757.612119394008;7786.7663970080985;7832.373410127176;7860.213978602152;7887.290143887078;4667.603253723438;4718.575328220477;4739.7630118493935;4760.928586071212;4774.331593576902;3105.1305634422397;3156.510740835174;3180.3321302526265;3191.69678880506;3225.4355487789544;1020.9693709188662;1041.4896700616719;1043.410473082706;1062.0759938853248;1076.2950267574752;10711.517981690842;10717.9464102679;10745.247832651796;10772.515236814284;10788.352698838095;4170.311898536707;4239.364095385717;4252.638525725286;4255.340422234559;4303.440552728188;8706.521141337287;8710.346723995599;8722.520261385558;8723.956380218058;8733.03936566977;4737.95262047382;4746.59653929413;4755.643326750507;4782.952170478251;4802.903941921142;4347.5652434756275;4349.521552629209;4357.172137293904;4359.629431498295;4416.138852923649;3404.472306792451;3421.8289085545625;3430.6740859618294;3434.587849458031;3458.602260739997;1035.3529044347283;1038.2939601071344;1045.6340280901622;1050.4380156616173;1063.9734006649742;1014.3761586624173;1021.8058568871891;1085.696005118568;1157.5254145800182;1313.481174935895;7351.742689005859;7447.329740323288;7455.813604659927;7468.813279668052;7529.058867641545;1012.7265638277623;1036.7770929250248;1110.3448965110624;1118.189312748251;1164.1152723929874;5749.3963133871175;5831.766729330864;5833.183354330312;5864.530837532987;5881.852953676107;9211.815763684688;9308.720738377859;9312.767180820398;9411.717648470556;9430.62277508892;9252.074792520694;9307.022762609964;9377.953110234404;9384.67153649619;9428.387154834914;6956.686949087303;7061.470389720689;7194.352508274281;7231.638418079075;7290.3438690518105;7188.784336469915;7281.126264848041;7291.197968223385;7321.926780732125;7339.376153027052;8173.427860049977;8196.959015204886;8238.670453182045;8390.244877961013;8419.158084191777;8193.262606365455;8363.916360836558;8384.58077096155;8385.454945428528;8499.915000849913;6797.592144471348;6831.6242606657115;6894.069300644349;6897.7240910365035;6913.89629155553;7484.401247900264;7528.473006889465;7561.432892532972;7572.848543028998;7589.924100759143;6812.14848143982;6937.826554336182;6966.547174433848;6996.895046574204;7079.646017698991;6251.9687401562705;6451.41937225652;6546.7888440638635;6929.648718499844;7110;7145.321194486515;7175.712971481291;7190.676419561237;7193.676284567103;7216.278372162742;6488.513361497812;6543.280239173782;6564.37638424368;6571.145751052332;6575.835604109936;6497.285298617243;6551.901721474277;6561.80314590563;6562.77030303937;6612.140421745143 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.54868701596354;341.9401604719175;343.07541176529264;349.325801203677;351.9401701710709;6257.843553911149;6292.779752708656;6297.433231009209;6310.053491976206;6475.579087359319;6267.185265915436;6272.278687950887;6297.622142671443;6304.180456540655;6322.462590679786;4767.332573439721;4778.402699662543;4781.569658730714;4789.449213340476;4791.257355109946;4745;4796.280557916306;4796.496367881375;4797.160496913044;4804.423469183703;4594.770261486929;4705.976470117662;4706.505816889228;4713.363695901044;4721.079389519045;4688.921548043952;4703.2474804031535;4710.481846996828;4714.127886341038;4714.57568818808;4076.694247931417;4087.264292427362;4089.754614723126;4092.4884389451317;4095.7337773044655;5882.411758824083;5893.58744887858;5928.851778705523;5951.2858456985;5962.07587823888;5413.377461591928;5462.289902312714;5486.1222204447495;5497.945020549783;5498.3127109111365;6632.436242919358;6656.667166641697;6660.167479065117;6667.899981500282;6678.332166783282;4451.1765323415275;4487.41663583732;4487.596116349511;4502.909941801178;4504.774761261924;6770.187577490733;6840.486963477759;6903.965480172617;6917.757878474229;6928.757493487704;4628.83799067031;4634.907301854011;4640.582347588733;4643.257078867433;4648.907021859543;4681.250999840009;4682.4381074271305;4683.695559788671;4684.718916864999;4685.906281874343;5447.264619276426;5455.972720136374;5457.045017121988;5475.835724928259;5478.835634930959;6478.060681201199;6661.700223489955;6669.699863506057;6710.865782684416;6770.69531871067;1612.3711752416566;1635.9918200408922;1641.6142206581444;1646.300322362991;1650.9587260318588;1059.5443959097508;1077.6605369308643;1080.8974845657385;1085.9022687958122;1088.542812018954;6309.526785491106;6328.588641738273;6357.205349331333;6371.076193951851;6389.361063893573;6757.93242067573;6768.7292508299115;6768.932310676831;6791.117154769947;6809;6179.783707570214;6318.273398559225;6322.462590679752;6333.46165575922;6345.936540634627;3714.9442758358646;3718.795466249382;3720.330340538729;3727.4781530585738;3735.2716220337315;6972.2330543640155;7046.837271850088;7050.753223637251;7075.787726368218;7084.539504932163;6804.11546498952;6937.271586483447;6971.5468494547695;6986.895196572055;6987.790366289019;7001.229864714877;7028.859422811515;7041.683124259421;7046.43628509718;7046.894296585555;6733.966330168318;6755.966220168868;6760.898586521304;6765.120534330702;6797.0823938767635;6562.261000834878;6614.570052946543;6665;6693.531452798257;6695.4308883745425;7034.226235114031;7036.612986285599;7037.894431583428;7038.683259253244;7038.788836334918;4572.062727140995;4582.9312560310955;4600.861974140781;4605.723656580616;4618.330342100444;6710.295418981132;6718.596884186964;6756.797296081126;6773.695183716646;6873.518853680194;6645.534812563074;6696.799096026932;6715.832104197239;6734.292899245509;6757.189137303555;6704.229013663491;6711.4966377520905;6721.966390168018;6722.327767223239;6736.157980252468;6398.232212134573;6520.250171230369;6521.054447105048;6521.184851893513;6534.83662908412;6701.1623547056615;6701.497387696039;6727.562708423937;6741.797746067626;6746.9325306746305;6504.869902602016;6539.149910511603;6559.376859198369;6559.4752419807255;6595 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: |5;yui.html;852.6205838401905;859.2953777902121;860.5826174305465;867.1285358214993;869.9217070463659;13784.862151378496;14114.858851411484;14124.71750564988;14136.787948180772;14158.079724817879;12859.935700321485;12934.676633084178;12956;12974.15667981583;13027.153235039716;792.5957761541626;806.4637016384127;808.7169490678274;817.6238930092135;832.1304237072274;816.8652172391548;817.9222973817477;822.6709316273509;823.3865770001357;823.851706692795;868.9044205137429;869.256785448442;871.4335681806845;871.559862269553;874.7200895713374;864.8270345930777;865.4417900454234;869.4739682492096;870.3602851903846;870.634333579898;630.6783540394385;631.2235949781748;633.1800318587441;634.3973225435808;636.4749082007316;14092.788608170886;14109.435622575085;14113.858861411358;14154.646133846632;14225.07537010091;11737.765244695143;11869.703257418547;12192.085593580518;12456.75086498265;13019.088663793538;10004.199664026934;10051.748706282402;10255.333403328834;11537;11619.76760464786;3591.6947059499976;3642.016655503026;3683;3737.0470530014672;3754.1177823211524;49298;49363.75318123422;49368.75315623435;49390.75304623454;49473;9849.310548261554;10179.796404072025;10253.74365640865;10400.323978941344;10745.979131982449;17739.73390399145;17753.644927101643;17774.46676599704;17796.644067118585;17815.376461823773;6415.454686351619;6608.8347791305605;6612.041254018237;6633.2371777246235;6804.931950680529;4156.916861662749;4195.035141917376;4204.285271503852;4213.91572168561;4236.68224883135;3080.7997480163717;3102.681360421812;3103.736182424474;3107.3163903941095;3112.066380085965;552.9695866727288;572.5076434266527;578.0808514462026;580.3847921203537;587.3216435017562;504.85106893466514;534.0333995468214;590.1973316289842;601.1433706967554;714.1002337055244;7943.563104029334;7947.3642108631175;8393.706220282262;8430.026517310647;8595.613197406132;651.3779340729592;659.9274079851212;683.1597135523334;689.9517033807585;697.5152269172978;3885.9611403886165;4011.4183443400543;4188.5811418857875;4279.495534936905;4301.612854843017;60332;60718.69640651769;60951;60999.39000610026;61425.38574614286;46767.29849052267;48362.51637483651;52816.207756883676;54013.45986540163;55468.44531554633;44770.3284450727;45183.322250166275;45557.772211139396;45902.31146532805;49466.50533494691;8260.215279548433;8481.830363392573;8663.610137543952;8738.956305218433;8854.424462409923;33749.325013500085;34212.82893585516;34764.652353477155;34774.82612586921;35274.47088293729;42595.787021064694;44365.77817110894;46622.53377466182;46751.53248467608;47064.529354706014;10121.089101980562;10180.338278011906;10570.894291056991;10578.259521833706;10924.453777310944;11378.146639001943;11770.234934729559;11807.704807379541;11842.52629894829;11949.940250298692;11057.557697692324;11079.556817727524;11242.718932026764;11250.099992000783;11576.486072819309;10170.644027459004;10396.16830653561;10409.323393979366;10459.110975567162;10461.790764184825;11133.832992504957;11481.081513479068;11516.53933842637;11822.231554948901;11942.880571194177;9489.098535639103;9651.083147101013;9697.175740062174;9751.317407781387;9921.305508614329;8781.604827782892;9011.459312441275;9329.253659707343;9403.059694030542;10139.239557033105 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,302 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:26:11 INFO - 2015-11-21 04:26:11,536 DEBUG : BROWSER_OUTPUT: __startTimestamp1448108771522__endTimestamp 04:26:11 INFO - 2015-11-21 04:26:11,537 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:26:11 INFO - 2015-11-21 04:26:11,537 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:26:11 INFO - 2015-11-21 04:26:11,537 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,537 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5519.19 Median:5753.54 stddev:623.14 (10.8%) stddev-sans-first:598.72 04:26:11 INFO - 2015-11-21 04:26:11,538 DEBUG : BROWSER_OUTPUT: Values: 3234.8 3260.7 3290.0 3311.1 3314.8 5227.5 5461.5 5470.2 5476.4 5492.2 5383.0 5395.1 5475.2 5554.1 5588.2 5031.3 5096.8 5155.0 5176.6 5179.3 4938.1 5006.8 5046.5 5100.9 5191.4 4892.1 4985.5 4990.1 5068.6 5105.7 5006.5 5018.3 5021.5 5065.6 5088.0 4999.5 5005.6 5012.6 5035.9 5046.4 5323.5 5329.6 5333.2 5334.7 5336.3 5745.9 5867.0 5883.1 6002.7 6009.5 6043.9 6054.9 6059.9 6066.2 6076.4 5620.3 5620.7 5624.9 5631.7 5636.9 5786.1 5852.6 6030.3 6103.6 6111.0 5849.5 5897.7 5905.5 5910.6 5940.5 5792.9 5923.5 5975.0 5975.3 5988.9 5840.3 5850.4 5911.3 5950.0 5983.6 5932.7 5957.4 5959.8 5960.2 5960.3 4429.5 4570.5 4579.1 4584.2 4622.1 4012.5 4022.3 4046.3 4073.1 4083.1 5644.2 5698.1 5716.2 5724.6 5725.4 5759.7 5873.2 5999.9 6084.2 6095.2 5677.0 5731.2 5754.8 5755.4 5802.6 5088.1 5135.9 5142.9 5156.3 5174.6 5776.3 6022.9 6093.1 6149.2 6167.2 5950.5 5988.8 5990.8 6051.4 6076.1 6087.3 6102.3 6106.7 6133.5 6179.5 5767.2 5851.1 5856.6 5864.6 5903.1 5913.6 5975.5 5990.6 6048.8 6081.1 5828.1 5833.2 5846.1 5858.7 5859.9 5582.4 5705.5 5737.5 5818.7 5823.7 5605.1 5684.9 5687.8 5695.7 5753.5 5874.2 5888.7 5917.9 5951.1 5956.7 5657.3 5720.1 5756.1 5756.7 5826.4 04:26:11 INFO - 2015-11-21 04:26:11,538 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,538 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48275.07 Median:39929.60 stddev:79866.59 (200.0%) stddev-sans-first:80010.33 04:26:11 INFO - 2015-11-21 04:26:11,538 DEBUG : BROWSER_OUTPUT: Values: 573.3 580.5 590.1 607.3 609.7 36423.6 36999.3 37309.0 37330.8 37337.0 39230.4 39638.4 39662.4 39666.6 39668.4 8666.1 8751.0 8785.4 8811.6 8846.6 8607.7 8693.8 8733.6 8746.4 8750.0 8685.0 8686.1 8688.7 8691.8 8721.0 8641.6 8652.1 8669.2 8724.0 8746.7 8501.9 8639.7 8650.5 8672.8 8673.3 39300.7 39805.6 39833.2 39875.2 39984.0 2945.9 3133.8 3236.6 3357.4 3826.8 28953.6 28989.0 29387.9 29455.9 30408.0 3865.8 3865.8 3888.4 3943.5 4033.2 265023.0 267456.0 268294.0 271436.0 279168.0 43844.3 66505.7 68706.7 68707.3 68782.7 60598.4 60891.0 61085.4 61239.0 61246.8 13589.6 13679.7 13715.7 13773.4 13876.9 9868.9 9881.4 9918.8 10011.6 10029.9 19951.4 19976.7 20076.3 20267.6 20315.5 7614.0 7829.8 7874.2 7901.7 7991.8 844.9 867.0 891.8 928.8 1104.3 28043.6 28228.7 28340.3 28468.0 28694.0 943.3 946.8 965.2 977.6 989.1 14171.1 14655.3 16535.3 16975.4 17112.9 354870.0 354925.0 355695.0 355723.0 357856.0 53964.5 54713.5 54782.2 54788.5 54894.5 1236.3 1258.5 1264.3 1264.3 1429.2 29344.9 30263.1 32223.2 32617.1 33071.7 48843.8 49532.5 49568.8 49651.3 49699.3 280362.0 282369.0 282789.0 282909.0 283018.0 42361.2 42734.1 42801.0 42920.3 43290.8 48597.5 50112.0 50639.5 51219.5 51312.7 41089.4 42362.8 42534.4 43041.1 43448.0 36869.8 37000.3 37036.0 37044.8 37184.4 40319.2 40536.6 40683.0 41071.0 41287.2 30741.5 31196.5 33005.2 33618.0 35583.4 25857.1 26504.7 26754.5 27855.4 28405.7 04:26:11 INFO - 2015-11-21 04:26:11,538 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,539 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27522.52 Median:2300.43 stddev:83320.24 (3621.9%) stddev-sans-first:83529.00 04:26:11 INFO - 2015-11-21 04:26:11,540 DEBUG : BROWSER_OUTPUT: Values: 354.7 355.6 360.2 361.9 365.1 16559.8 16898.7 17382.7 17520.2 17990.4 14161.3 15682.3 16225.9 16800.7 16944.2 4828.5 4885.2 4916.9 4946.6 4948.1 4851.9 4864.4 4877.1 4898.0 4927.2 5004.4 5151.8 5190.7 5301.1 5314.4 5205.2 5216.4 5219.9 5225.2 5563.4 5061.7 5062.1 5064.8 5086.9 5095.7 18214.8 18542.7 18571.4 18626.9 18830.4 2029.7 2058.7 2075.1 2118.3 2174.1 9554.0 9678.3 11248.0 12163.6 13200.7 1576.4 1585.1 1599.3 1625.7 1629.6 57234.4 61405.7 62167.7 62454.4 62628.0 9937.8 10113.3 10291.5 10451.9 10478.9 12628.4 12702.8 12703.4 12711.2 12790.7 6641.5 6824.4 6909.2 7051.1 7098.3 6025.1 6047.8 6356.6 6546.7 6586.6 4235.8 4348.8 4525.8 4540.6 4562.7 1835.3 1856.7 1925.9 1934.1 1947.8 806.1 813.7 823.6 842.4 855.5 16288.8 16426.0 16491.3 16769.3 16956.0 882.5 897.6 907.0 914.3 919.4 9280.1 9386.7 9497.8 9542.7 9658.2 497691.0 501185.0 503769.0 521906.0 522614.0 76194.0 77461.0 78128.2 78132.2 78937.2 1068.3 1072.3 1076.1 1078.6 1086.0 14163.8 14337.8 14441.7 14472.6 15406.4 33476.7 33823.8 34252.7 34897.7 35021.5 42934.4 44233.8 45604.3 45607.0 45966.0 9166.0 9603.5 9623.4 9658.5 9736.0 11123.7 11133.6 11203.8 11249.4 12555.4 13089.5 13320.3 13436.7 13530.5 13791.5 14148.9 14224.5 14442.3 14665.5 14976.4 13868.3 14009.2 14298.3 14455.5 14589.4 9038.1 9157.9 9468.2 9591.5 9832.6 9984.3 10091.9 13862.7 13870.7 13982.2 04:26:11 INFO - 2015-11-21 04:26:11,540 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,540 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5458.82 Median:6351.69 stddev:2806.22 (44.2%) stddev-sans-first:2798.03 04:26:11 INFO - 2015-11-21 04:26:11,540 DEBUG : BROWSER_OUTPUT: Values: 1464.5 1528.8 1586.7 1679.9 1791.7 7343.4 7656.3 7837.7 7861.9 7870.8 7828.1 7901.0 7920.1 7966.7 8025.3 2293.4 2313.5 2318.9 2332.5 2333.6 2268.2 2300.7 2305.3 2307.6 2308.5 2248.4 2284.6 2318.7 2324.0 2326.1 2261.7 2304.2 2344.0 2345.5 2348.7 2299.4 2358.1 2370.6 2372.2 2372.5 7757.6 7786.8 7832.4 7860.2 7887.3 4667.6 4718.6 4739.8 4760.9 4774.3 3105.1 3156.5 3180.3 3191.7 3225.4 1021.0 1041.5 1043.4 1062.1 1076.3 10711.5 10717.9 10745.2 10772.5 10788.4 4170.3 4239.4 4252.6 4255.3 4303.4 8706.5 8710.3 8722.5 8724.0 8733.0 4738.0 4746.6 4755.6 4783.0 4802.9 4347.6 4349.5 4357.2 4359.6 4416.1 3404.5 3421.8 3430.7 3434.6 3458.6 1035.4 1038.3 1045.6 1050.4 1064.0 1014.4 1021.8 1085.7 1157.5 1313.5 7351.7 7447.3 7455.8 7468.8 7529.1 1012.7 1036.8 1110.3 1118.2 1164.1 5749.4 5831.8 5833.2 5864.5 5881.9 9211.8 9308.7 9312.8 9411.7 9430.6 9252.1 9307.0 9378.0 9384.7 9428.4 6956.7 7061.5 7194.4 7231.6 7290.3 7188.8 7281.1 7291.2 7321.9 7339.4 8173.4 8197.0 8238.7 8390.2 8419.2 8193.3 8363.9 8384.6 8385.5 8499.9 6797.6 6831.6 6894.1 6897.7 6913.9 7484.4 7528.5 7561.4 7572.8 7589.9 6812.1 6937.8 6966.5 6996.9 7079.6 6252.0 6451.4 6546.8 6929.6 7110.0 7145.3 7175.7 7190.7 7193.7 7216.3 6488.5 6543.3 6564.4 6571.1 6575.8 6497.3 6551.9 6561.8 6562.8 6612.1 04:26:11 INFO - 2015-11-21 04:26:11,540 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,540 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5521.45 Median:6320.37 stddev:1680.40 (26.6%) stddev-sans-first:1639.42 04:26:11 INFO - 2015-11-21 04:26:11,541 DEBUG : BROWSER_OUTPUT: Values: 335.5 341.9 343.1 349.3 351.9 6257.8 6292.8 6297.4 6310.1 6475.6 6267.2 6272.3 6297.6 6304.2 6322.5 4767.3 4778.4 4781.6 4789.4 4791.3 4745.0 4796.3 4796.5 4797.2 4804.4 4594.8 4706.0 4706.5 4713.4 4721.1 4688.9 4703.2 4710.5 4714.1 4714.6 4076.7 4087.3 4089.8 4092.5 4095.7 5882.4 5893.6 5928.9 5951.3 5962.1 5413.4 5462.3 5486.1 5497.9 5498.3 6632.4 6656.7 6660.2 6667.9 6678.3 4451.2 4487.4 4487.6 4502.9 4504.8 6770.2 6840.5 6904.0 6917.8 6928.8 4628.8 4634.9 4640.6 4643.3 4648.9 4681.3 4682.4 4683.7 4684.7 4685.9 5447.3 5456.0 5457.0 5475.8 5478.8 6478.1 6661.7 6669.7 6710.9 6770.7 1612.4 1636.0 1641.6 1646.3 1651.0 1059.5 1077.7 1080.9 1085.9 1088.5 6309.5 6328.6 6357.2 6371.1 6389.4 6757.9 6768.7 6768.9 6791.1 6809.0 6179.8 6318.3 6322.5 6333.5 6345.9 3714.9 3718.8 3720.3 3727.5 3735.3 6972.2 7046.8 7050.8 7075.8 7084.5 6804.1 6937.3 6971.5 6986.9 6987.8 7001.2 7028.9 7041.7 7046.4 7046.9 6734.0 6756.0 6760.9 6765.1 6797.1 6562.3 6614.6 6665.0 6693.5 6695.4 7034.2 7036.6 7037.9 7038.7 7038.8 4572.1 4582.9 4600.9 4605.7 4618.3 6710.3 6718.6 6756.8 6773.7 6873.5 6645.5 6696.8 6715.8 6734.3 6757.2 6704.2 6711.5 6722.0 6722.3 6736.2 6398.2 6520.3 6521.1 6521.2 6534.8 6701.2 6701.5 6727.6 6741.8 6746.9 6504.9 6539.1 6559.4 6559.5 6595.0 04:26:11 INFO - 2015-11-21 04:26:11,541 DEBUG : BROWSER_OUTPUT: 04:26:11 INFO - 2015-11-21 04:26:11,541 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13885.71 Median:46262.42 stddev:16346.82 (35.3%) stddev-sans-first:16363.38 04:26:11 INFO - 2015-11-21 04:26:11,542 DEBUG : BROWSER_OUTPUT: Values: 852.6 859.3 860.6 867.1 869.9 13784.9 14114.9 14124.7 14136.8 14158.1 12859.9 12934.7 12956.0 12974.2 13027.2 792.6 806.5 808.7 817.6 832.1 816.9 817.9 822.7 823.4 823.9 868.9 869.3 871.4 871.6 874.7 864.8 865.4 869.5 870.4 870.6 630.7 631.2 633.2 634.4 636.5 14092.8 14109.4 14113.9 14154.6 14225.1 11737.8 11869.7 12192.1 12456.8 13019.1 10004.2 10051.7 10255.3 11537.0 11619.8 3591.7 3642.0 3683.0 3737.0 3754.1 49298.0 49363.8 49368.8 49390.8 49473.0 9849.3 10179.8 10253.7 10400.3 10746.0 17739.7 17753.6 17774.5 17796.6 17815.4 6415.5 6608.8 6612.0 6633.2 6804.9 4156.9 4195.0 4204.3 4213.9 4236.7 3080.8 3102.7 3103.7 3107.3 3112.1 553.0 572.5 578.1 580.4 587.3 504.9 534.0 590.2 601.1 714.1 7943.6 7947.4 8393.7 8430.0 8595.6 651.4 659.9 683.2 690.0 697.5 3886.0 4011.4 4188.6 4279.5 4301.6 60332.0 60718.7 60951.0 60999.4 61425.4 46767.3 48362.5 52816.2 54013.5 55468.4 44770.3 45183.3 45557.8 45902.3 49466.5 8260.2 8481.8 8663.6 8739.0 8854.4 33749.3 34212.8 34764.7 34774.8 35274.5 42595.8 44365.8 46622.5 46751.5 47064.5 10121.1 10180.3 10570.9 10578.3 10924.5 11378.1 11770.2 11807.7 11842.5 11949.9 11057.6 11079.6 11242.7 11250.1 11576.5 10170.6 10396.2 10409.3 10459.1 10461.8 11133.8 11481.1 11516.5 11822.2 11942.9 9489.1 9651.1 9697.2 9751.3 9921.3 8781.6 9011.5 9329.3 9403.1 10139.2 04:26:11 INFO - 2015-11-21 04:26:11,542 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:26:11 INFO - 2015-11-21 04:26:11,542 DEBUG : BROWSER_OUTPUT: 04:26:12 INFO - 2015-11-21 04:26:12,203 INFO : Browser exited with error code: 0 04:26:12 INFO - 2015-11-21 04:26:12,224 INFO : Completed test dromaeo_css (00:18:30) 04:26:12 INFO - 2015-11-21 04:26:12,224 INFO : Starting test kraken 04:26:12 INFO - 2015-11-21 04:26:12,224 DEBUG : operating with platform_type : linux_ 04:26:12 INFO - 2015-11-21 04:26:12,224 INFO : Initialising browser for kraken test... 04:26:12 INFO - 2015-11-21 04:26:12,230 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfPKXn7/profile http://localhost:44263/getInfo.html 04:26:16 INFO - 2015-11-21 04:26:16,528 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:26:16 INFO - 2015-11-21 04:26:16,528 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:26:16 INFO - 2015-11-21 04:26:16,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:26:16 INFO - 2015-11-21 04:26:16,529 DEBUG : BROWSER_OUTPUT: __metrics 04:26:17 INFO - 2015-11-21 04:26:17,531 INFO : Browser initialized. 04:26:17 INFO - 2015-11-21 04:26:17,531 INFO : Running cycle 1/1 for kraken test... 04:26:17 INFO - 2015-11-21 04:26:17,531 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfPKXn7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:26:29 INFO - 2015-11-21 04:26:29,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 142200832 04:26:29 INFO - 2015-11-21 04:26:29,294 DEBUG : BROWSER_OUTPUT: 04:26:31 INFO - 2015-11-21 04:26:31,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:32 INFO - 2015-11-21 04:26:32,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 141893632 04:26:32 INFO - 2015-11-21 04:26:32,351 DEBUG : BROWSER_OUTPUT: 04:26:34 INFO - 2015-11-21 04:26:34,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-dft) 04:26:35 INFO - 2015-11-21 04:26:35,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 142225408 04:26:35 INFO - 2015-11-21 04:26:35,587 DEBUG : BROWSER_OUTPUT: 04:26:38 INFO - 2015-11-21 04:26:38,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-fft) 04:26:38 INFO - 2015-11-21 04:26:38,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 04:26:38 INFO - 2015-11-21 04:26:38,985 DEBUG : BROWSER_OUTPUT: 04:26:40 INFO - 2015-11-21 04:26:40,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-oscillator) 04:26:41 INFO - 2015-11-21 04:26:41,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 138063872 04:26:41 INFO - 2015-11-21 04:26:41,598 DEBUG : BROWSER_OUTPUT: 04:26:43 INFO - 2015-11-21 04:26:43,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:44 INFO - 2015-11-21 04:26:44,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 136536064 04:26:44 INFO - 2015-11-21 04:26:44,352 DEBUG : BROWSER_OUTPUT: 04:26:47 INFO - 2015-11-21 04:26:47,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44263/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:47 INFO - 2015-11-21 04:26:47,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 138129408 04:26:47 INFO - 2015-11-21 04:26:47,929 DEBUG : BROWSER_OUTPUT: 04:26:51 INFO - 2015-11-21 04:26:51,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44263/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:51 INFO - 2015-11-21 04:26:51,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 138891264 04:26:51 INFO - 2015-11-21 04:26:51,929 DEBUG : BROWSER_OUTPUT: 04:26:54 INFO - 2015-11-21 04:26:54,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44263/tests/kraken/driver.html?testName=json-parse-financial) 04:26:55 INFO - 2015-11-21 04:26:55,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 139370496 04:26:55 INFO - 2015-11-21 04:26:55,377 DEBUG : BROWSER_OUTPUT: 04:26:56 INFO - 2015-11-21 04:26:56,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:57 INFO - 2015-11-21 04:26:57,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 04:26:57 INFO - 2015-11-21 04:26:57,567 DEBUG : BROWSER_OUTPUT: 04:26:59 INFO - 2015-11-21 04:26:59,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:59 INFO - 2015-11-21 04:26:59,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 04:26:59 INFO - 2015-11-21 04:26:59,983 DEBUG : BROWSER_OUTPUT: 04:27:02 INFO - 2015-11-21 04:27:02,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:02 INFO - 2015-11-21 04:27:02,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 140464128 04:27:02 INFO - 2015-11-21 04:27:02,652 DEBUG : BROWSER_OUTPUT: 04:27:05 INFO - 2015-11-21 04:27:05,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:05 INFO - 2015-11-21 04:27:05,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 140054528 04:27:05 INFO - 2015-11-21 04:27:05,741 DEBUG : BROWSER_OUTPUT: 04:27:08 INFO - 2015-11-21 04:27:08,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:08 INFO - 2015-11-21 04:27:08,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 139087872 04:27:08 INFO - 2015-11-21 04:27:08,918 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44263/tests/kraken/driver.html?testName=ai-astar) 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 139087872 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;110;112;112;123;110;110;110;111 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;125;157;170;127;151;147;126;169;125 04:27:10 INFO - 2015-11-21 04:27:10,863 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;163;164;161;163;165;179;163 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;72;73;75;74;141;72;73;72 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;91;139;91;91;91;134;90;90;138 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;111;109;110;110;110;119 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;149;148;147;147;147;148;147;147 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;97;96;98;96;96;96;96 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;66;66;66;66;66;66;66;63;63 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;69;69;71;70;70 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;86;87;86;86;86;86;85;86 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;113;128;125;123;128;125;118;120;125 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;159;151;151;150;142;150;151;158;146 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;69;67;67;67;69;70;69;70 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:27:10 INFO - 2015-11-21 04:27:10,864 DEBUG : BROWSER_OUTPUT: __startTimestamp1448108830861__endTimestamp 04:27:10 INFO - 2015-11-21 04:27:10,865 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:4.53 (4.1%) stddev-sans-first:4.80 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 110.0 112.0 112.0 123.0 110.0 110.0 110.0 111.0 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.00 stddev:18.16 (11.9%) stddev-sans-first:18.92 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: Values: 155.0 125.0 157.0 170.0 127.0 151.0 147.0 126.0 169.0 125.0 04:27:10 INFO - 2015-11-21 04:27:10,866 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:5.21 (3.2%) stddev-sans-first:5.50 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 163.0 164.0 161.0 163.0 165.0 179.0 163.0 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:73.00 stddev:21.52 (29.5%) stddev-sans-first:22.69 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 73.0 75.0 74.0 141.0 72.0 73.0 72.0 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:91.00 stddev:22.27 (24.5%) stddev-sans-first:23.21 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: Values: 93.0 91.0 139.0 91.0 91.0 91.0 134.0 90.0 90.0 138.0 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,867 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:110.00 stddev:2.98 (2.7%) stddev-sans-first:3.15 04:27:10 INFO - 2015-11-21 04:27:10,868 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 111.0 109.0 110.0 110.0 110.0 119.0 04:27:10 INFO - 2015-11-21 04:27:10,868 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,868 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:27:10 INFO - 2015-11-21 04:27:10,868 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 149.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 04:27:10 INFO - 2015-11-21 04:27:10,868 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,868 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 04:27:10 INFO - 2015-11-21 04:27:10,869 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 97.0 96.0 98.0 96.0 96.0 96.0 96.0 04:27:10 INFO - 2015-11-21 04:27:10,869 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,870 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 04:27:10 INFO - 2015-11-21 04:27:10,870 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 63.0 63.0 04:27:10 INFO - 2015-11-21 04:27:10,870 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,870 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 69.0 69.0 71.0 70.0 70.0 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 86.0 87.0 86.0 86.0 86.0 86.0 85.0 86.0 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:125.00 stddev:4.90 (3.9%) stddev-sans-first:4.94 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: Values: 118.0 113.0 128.0 125.0 123.0 128.0 125.0 118.0 120.0 125.0 04:27:10 INFO - 2015-11-21 04:27:10,871 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:6.03 (4.0%) stddev-sans-first:5.25 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: Values: 140.0 159.0 151.0 151.0 150.0 142.0 150.0 151.0 158.0 146.0 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.45 (2.1%) stddev-sans-first:1.48 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 69.0 67.0 67.0 67.0 69.0 70.0 69.0 70.0 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:10 INFO - 2015-11-21 04:27:10,872 DEBUG : BROWSER_OUTPUT: 04:27:11 INFO - 2015-11-21 04:27:11,707 INFO : Browser exited with error code: 0 04:27:11 INFO - 2015-11-21 04:27:11,756 INFO : Completed test kraken (00:00:59) 04:27:11 INFO - 2015-11-21 04:27:11,756 INFO : Starting test v8_7 04:27:11 INFO - 2015-11-21 04:27:11,756 DEBUG : operating with platform_type : linux_ 04:27:11 INFO - 2015-11-21 04:27:11,756 INFO : Initialising browser for v8_7 test... 04:27:11 INFO - 2015-11-21 04:27:11,762 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpha2J5i/profile http://localhost:44263/getInfo.html 04:27:16 INFO - 2015-11-21 04:27:16,172 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:16 INFO - 2015-11-21 04:27:16,172 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:16 INFO - 2015-11-21 04:27:16,173 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:16 INFO - 2015-11-21 04:27:16,173 DEBUG : BROWSER_OUTPUT: __metrics 04:27:17 INFO - 2015-11-21 04:27:17,227 INFO : Browser initialized. 04:27:17 INFO - 2015-11-21 04:27:17,227 INFO : Running cycle 1/1 for v8_7 test... 04:27:17 INFO - 2015-11-21 04:27:17,228 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpha2J5i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:29 INFO - 2015-11-21 04:27:29,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 04:27:29 INFO - 2015-11-21 04:27:29,010 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44263/tests/v8_7/run.html (next: http://localhost:44263/tests/v8_7/run.html) 04:27:50 INFO - 2015-11-21 04:27:50,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 04:27:50 INFO - 2015-11-21 04:27:50,667 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,667 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:50 INFO - 2015-11-21 04:27:50,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:50 INFO - 2015-11-21 04:27:50,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:50 INFO - 2015-11-21 04:27:50,667 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:50 INFO - 2015-11-21 04:27:50,668 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6451880072884 04:27:50 INFO - 2015-11-21 04:27:50,668 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.75250578257518 04:27:50 INFO - 2015-11-21 04:27:50,668 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.5511136493432 04:27:50 INFO - 2015-11-21 04:27:50,668 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 04:27:50 INFO - 2015-11-21 04:27:50,668 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1061.5711252653928 04:27:50 INFO - 2015-11-21 04:27:50,668 DEBUG : BROWSER_OUTPUT: |5;Earley;704.7216349541931 04:27:50 INFO - 2015-11-21 04:27:50,669 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 04:27:50 INFO - 2015-11-21 04:27:50,669 DEBUG : BROWSER_OUTPUT: |7;RegExp;25175 04:27:50 INFO - 2015-11-21 04:27:50,669 DEBUG : BROWSER_OUTPUT: |8;Splay;611.0436893203884 04:27:50 INFO - 2015-11-21 04:27:50,669 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:27:50 INFO - 2015-11-21 04:27:50,669 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:50 INFO - 2015-11-21 04:27:50,670 DEBUG : BROWSER_OUTPUT: __startTimestamp1448108870660__endTimestamp 04:27:50 INFO - 2015-11-21 04:27:50,670 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,670 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:50 INFO - 2015-11-21 04:27:50,670 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:27:50 INFO - 2015-11-21 04:27:50,670 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,670 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: Values: 165.6 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.75 Median:192.75 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: Values: 192.8 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.55 Median:285.55 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,671 DEBUG : BROWSER_OUTPUT: Values: 285.6 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: Values: 5050.5 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: Values: 1061.6 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,672 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: Values: 704.7 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: Values: 12219.5 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25175.00 Median:25175.00 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,673 DEBUG : BROWSER_OUTPUT: Values: 25175.0 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.04 Median:611.04 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: Values: 611.0 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:27:50 INFO - 2015-11-21 04:27:50,674 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:50 INFO - 2015-11-21 04:27:50,675 DEBUG : BROWSER_OUTPUT: 04:27:51 INFO - 2015-11-21 04:27:51,559 INFO : Browser exited with error code: 0 04:27:51 INFO - 2015-11-21 04:27:51,571 INFO : Completed test v8_7 (00:00:39) 04:27:51 INFO - 2015-11-21 04:27:51,705 INFO : Completed test suite (00:20:10) 04:27:51 INFO - 2015-11-21 04:27:51,705 DEBUG : Working with test: dromaeo_css 04:27:51 INFO - 2015-11-21 04:27:51,705 DEBUG : Generating results file: dromaeo_css 04:27:51 INFO - 2015-11-21 04:27:51,707 DEBUG : Working with test: kraken 04:27:51 INFO - 2015-11-21 04:27:51,707 DEBUG : Generating results file: kraken 04:27:51 INFO - 2015-11-21 04:27:51,707 INFO : javascript benchmark 04:27:51 INFO - 2015-11-21 04:27:51,707 DEBUG : Working with test: v8_7 04:27:51 INFO - 2015-11-21 04:27:51,707 DEBUG : Generating results file: v8_7 04:27:51 INFO - 2015-11-21 04:27:51,708 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:51 INFO - 2015-11-21 04:27:51,747 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 04:27:51 INFO - 2015-11-21 04:27:51,747 DEBUG : process_Request line: dromaeo_css 7053.93 graph.html#tests=[[72,64,43]] 04:27:51 INFO - 2015-11-21 04:27:51,748 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:51 INFO - 2015-11-21 04:27:51,776 DEBUG : process_Request line: kraken 1521.90 graph.html#tests=[[232,64,43]] 04:27:51 INFO - 2015-11-21 04:27:51,776 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:51 INFO - 2015-11-21 04:27:51,802 DEBUG : process_Request line: v8_7 21373.24 graph.html#tests=[[230,64,43]] 04:27:51 INFO - 2015-11-21 04:27:51,803 INFO : javascript benchmark 04:27:51 INFO - 2015-11-21 04:27:51,807 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3234.7897386669865, 3260.6902344277287, 3289.983550082249, 3311.0894504011394, 3314.7679662423625, 5227.503387178222, 5461.453854614537, 5470.179473079035, 5476.3702174249975, 5492.203630473579, 5382.9730851345685, 5395.082835917893, 5475.151351540508, 5554.1113421852515, 5588.161775733642, 5031.295618613397, 5096.770645320969, 5154.974225128888, 5176.55999240065, 5179.2749015137915, 4938.1111399947995, 5006.774695138727, 5046.495350464943, 5100.923486147711, 5191.402988656297, 4892.119418504668, 4985.501449855022, 4990.126727822653, 5068.594512439015, 5105.693658380491, 5006.524380183877, 5018.2974383586325, 5021.497850214986, 5065.594752419797, 5088.0078384715, 4999.475055119196, 5005.57452616528, 5012.649114561982, 5035.92446113305, 5046.394432668103, 5323.467653234646, 5329.600279979017, 5333.226682131108, 5334.706591137486, 5336.332958380202, 5745.942540574624, 5867.0, 5883.146943693183, 6002.699865006776, 6009.549283803733, 6043.909341359883, 6054.939450605526, 6059.909101363483, 6066.181065556138, 6076.392360763933, 5620.297462817148, 5620.662760234399, 5624.903143886943, 5631.690257035862, 5636.928983493205, 5786.132080187921, 5852.648841069465, 6030.276366836008, 6103.640733310809, 6110.984061328612, 5849.473547380756, 5897.67562784051, 5905.498032667271, 5910.586258961831, 5940.46535811779, 5792.88414231713, 5923.49650279731, 5975.0, 5975.312839023481, 5988.850278742979, 5840.328362238312, 5850.3564607893095, 5911.261092363455, 5950.018246989285, 5983.551233657493, 5932.7330270137945, 5957.434043765836, 5959.821205363846, 5960.195373624505, 5960.314563825129, 4429.512753597101, 4570.4972453030805, 4579.061292435043, 4584.243599805995, 4622.098690755338, 4012.518497780285, 4022.3363145080734, 4046.3121269384274, 4073.06319546506, 4083.1017176221185, 5644.238027866268, 5698.1452782083015, 5716.1997320375185, 5724.627899186539, 5725.398833122462, 5759.740811663485, 5873.20711703923, 5999.880002399927, 6084.239470066242, 6095.177151084636, 5677.0, 5731.168980497804, 5754.769809207585, 5755.366909639936, 5802.564807639444, 5088.1350170471105, 5135.948640513622, 5142.922856157161, 5156.329677142023, 5174.611904107207, 5776.306843178845, 6022.879542409128, 6093.116498107838, 6149.200603921461, 6167.167432396659, 5950.464458198783, 5988.790392336247, 5990.820275391745, 6051.3948605140895, 6076.118962750465, 6087.269527656709, 6102.298235702951, 6106.664133472702, 6133.53998450127, 6179.5056395489155, 5767.192593036894, 5851.093080572518, 5856.560757943086, 5864.589478736448, 5903.0555111182, 5913.5564832636865, 5975.462208401264, 5990.550708696952, 6048.84877878039, 6081.148639190428, 5828.0966450200285, 5833.241678581757, 5846.123081537633, 5858.677772722541, 5859.882802343844, 5582.413846546055, 5705.486506214461, 5737.512311453574, 5818.650880947157, 5823.7379317931645, 5605.075162598126, 5684.9431505684415, 5687.800926967537, 5695.715214239189, 5753.539716822728, 5874.206982057539, 5888.735006924784, 5917.881642367042, 5951.137085122719, 5956.731947062306, 5657.264555607745, 5720.056190728483, 5756.0502517084215, 5756.68338241384, 5826.41735826414], "unit": "ms", "name": "dojo.html", "value": 5477.9454781338545}, {"lowerIsBetter": false, "replicates": [573.3349314794838, 580.5239703443176, 590.1089355073838, 607.2652090969929, 609.6616377910264, 36423.635763642356, 36999.260014799685, 37309.0, 37330.81334593327, 37337.0, 39230.41154382686, 39638.40542391859, 39662.43038126568, 39666.603333966654, 39668.40497392534, 8666.090060543647, 8750.956245218797, 8785.38502304839, 8811.647534098629, 8846.601902914352, 8607.655693772242, 8693.782655433633, 8733.563321833883, 8746.387752857303, 8750.0, 8685.0, 8686.131386861294, 8688.695895643654, 8691.826163476726, 8721.0, 8641.611127499245, 8652.091530389313, 8669.219770220647, 8724.040355560883, 8746.693865714702, 8501.914980850173, 8639.697610583662, 8650.524221167832, 8672.783180420476, 8673.349498787617, 39300.6594439473, 39805.60194398077, 39833.20333593341, 39875.20249595021, 39984.0, 2945.911622651324, 3133.7649676274373, 3236.6277878044093, 3357.446021406465, 3826.7512611680154, 28953.565696514568, 28989.0, 29387.853060734775, 29455.852720736475, 30408.0, 3865.845366185349, 3865.8453661853773, 3888.3972984187494, 3943.4873466449176, 4033.193361327717, 265023.0, 267456.0, 268294.0, 271436.0, 279168.0, 43844.342334865, 66505.66747166234, 68706.65646671735, 68707.31292687109, 68782.65608671925, 60598.394016060156, 60891.0, 61085.38914610797, 61238.957519885786, 61246.77506449935, 13589.59231223045, 13679.726405472034, 13715.657108572366, 13773.449062037405, 13876.930615346859, 9868.901310986941, 9881.357711748713, 9918.752031199278, 10011.599536018623, 10029.949850250701, 19951.401457956286, 19976.700349494768, 20076.297329593395, 20267.59464810725, 20315.492112697302, 7613.961930190424, 7829.804254893673, 7874.173211812677, 7901.723439679584, 7991.800204994922, 844.9493030418195, 866.9696560620474, 891.7503099132254, 928.8281667891462, 1104.3373975614568, 28043.579346309823, 28228.71771282302, 28340.291492712848, 28468.0, 28694.0, 943.3490891284991, 946.8248374050822, 965.1988849255101, 977.6089564174245, 989.1048601016092, 14171.149731016172, 14655.340509676877, 16535.338586456648, 16975.40586079506, 17112.914435427992, 354870.0, 354925.0, 355695.0, 355723.0, 357856.0, 53964.460355395946, 54713.452865471634, 54782.178267326024, 54788.45211547913, 54894.451055489735, 1236.3323805145121, 1258.5217617305366, 1264.3046324521476, 1264.3235868810143, 1429.2067902314107, 29344.853275733483, 30263.09210723682, 32223.194420139684, 32617.08594968619, 33071.66928330686, 48843.75578122087, 49532.50467495279, 49568.786653133444, 49651.25523117084, 49699.254511183084, 280362.0, 282369.0, 282789.0, 282909.0, 283018.0, 42361.15277694367, 42734.14531709411, 42801.0, 42920.283188673355, 43290.78354608333, 48597.5140248593, 50112.0, 50639.49360506495, 51219.48780512147, 51312.74343628258, 41089.38365924573, 42362.788186058875, 42534.361984570874, 43041.13917721566, 43448.0, 36869.81565092158, 37000.25999480049, 37036.0, 37044.814775925945, 37184.44223336598, 40319.193616126926, 40536.59463405328, 40682.9829254271, 41071.0, 41287.1742565153, 30741.53887691731, 31196.532052018785, 33005.17487062843, 33618.0, 35583.39874705593, 25857.09500167485, 26504.734952650226, 26754.46491070129, 27855.442891141658, 28405.715942840307], "unit": "ms", "name": "ext.html", "value": 18845.92490358516}, {"lowerIsBetter": false, "replicates": [354.7126827269913, 355.5608823103468, 360.2237178879514, 361.89143257022886, 365.0708945733109, 16559.834401655993, 16898.66202675946, 17382.652346953055, 17520.211590478426, 17990.370337038206, 14161.291935403215, 15682.294296756645, 16225.918870405632, 16800.663986720258, 16944.23750931208, 4828.541288577589, 4885.218365061591, 4916.926246106311, 4946.629002824785, 4948.134076536609, 4851.878703032435, 4864.367632207808, 4877.122118018755, 4898.0, 4927.211646136619, 5004.424491183524, 5151.793928242866, 5190.688558686472, 5301.125314323132, 5314.441983591725, 5205.219217117444, 5216.374035115791, 5219.921701174486, 5225.242339860737, 5563.415841336682, 5061.721605311706, 5062.139436295838, 5064.797408103708, 5086.949130508685, 5095.668781529189, 18214.817851821444, 18542.721859172125, 18571.44285671432, 18626.90686546572, 18830.435086947415, 2029.6549586570318, 2058.6603210470253, 2075.1180748182114, 2118.2797848731507, 2174.08688350893, 9554.0, 9678.27412944032, 11248.0, 12163.635090947286, 13200.73598528024, 1576.3930886608623, 1585.112337091221, 1599.3043026283603, 1625.6911186874574, 1629.6170399956002, 57234.427655723324, 61405.69297153486, 62167.689161553906, 62454.37545624531, 62628.0, 9937.80124397508, 10113.292069555207, 10291.485425728684, 10451.902550232267, 10478.895211047944, 12628.368581570885, 12702.80945785814, 12703.364831758376, 12711.237325760483, 12790.744185116246, 6641.535092543476, 6824.41992430639, 6909.205441374306, 7051.1186101737285, 7098.3256590623805, 6025.126356678257, 6047.78832740852, 6356.586821856565, 6546.70539825709, 6586.571872828346, 4235.788210589458, 4348.782560872007, 4525.7510836904285, 4540.636749060067, 4562.680612357103, 1835.2750663488114, 1856.7214917762174, 1925.894075825843, 1934.071645610087, 1947.8344340730914, 806.0931452116369, 813.7454592309612, 823.625250511016, 842.3850589070013, 855.482433127961, 16288.837111628969, 16426.0, 16491.257893394824, 16769.32922683079, 16956.0, 882.5057967538199, 897.6274845938992, 906.9796478961168, 914.2822884036, 919.4078457460027, 9280.118388753057, 9386.718398447922, 9497.810043799085, 9542.666006689733, 9658.227341812639, 497691.0, 501185.0, 503769.0, 521906.0, 522614.0, 76194.0, 77461.0, 78128.2187178121, 78132.21867781249, 78937.21062789414, 1068.3056013591229, 1072.3030030480095, 1076.1068313299943, 1078.5793540519203, 1085.9674209773718, 14163.787543186654, 14337.78493322622, 14441.711165776836, 14472.565823025327, 15406.383744650537, 33476.66523334833, 33823.83088084544, 34252.65747342594, 34897.65102348944, 35021.47467787934, 42934.35598466088, 44233.77883110692, 45604.31593526033, 45607.0, 45966.0, 9166.0, 9603.471809050568, 9623.374480658735, 9658.468784216935, 9736.0, 11123.66629001099, 11133.554657813596, 11203.775924481628, 11249.381284029458, 12555.448986931862, 13089.541866034642, 13320.267385293902, 13436.731265374834, 13530.526431574848, 13791.51729689456, 14148.929255354069, 14224.530300995244, 14442.277886105863, 14665.48670796517, 14976.400943962119, 13868.306584670525, 14009.159450433006, 14298.28508574588, 14455.49405770793, 14589.416423342947, 9038.141376569216, 9157.908420915972, 9468.248374050823, 9591.472469014272, 9832.557534910804, 9984.301098923297, 10091.949540252252, 13862.65343366424, 13870.72258554803, 13982.161070335813], "unit": "ms", "name": "jquery.html", "value": 8484.417257155439}, {"lowerIsBetter": false, "replicates": [1464.54599074287, 1528.816542014958, 1586.698527279816, 1679.8740094492916, 1791.7222830461283, 7343.4492413068965, 7656.349210317129, 7837.725679601215, 7861.921380786183, 7870.803229919247, 7828.138904720477, 7901.0, 7920.089189743181, 7966.681332746698, 8025.3178479829285, 2293.4495721027, 2313.4794671199015, 2318.8840557972035, 2332.54515369503, 2333.614953532665, 2268.2061278552455, 2300.723913130427, 2305.2738387408, 2307.5500277445904, 2308.4921317310163, 2248.3704562722464, 2284.6116160252795, 2318.686977258074, 2324.035525257025, 2326.0579465316573, 2261.705978222837, 2304.1820153845397, 2343.9765602343928, 2345.4839935214227, 2348.6829278047417, 2299.356180269527, 2358.056777289098, 2370.5969985102574, 2372.240882917467, 2372.466195106105, 7757.612119394008, 7786.7663970080985, 7832.373410127176, 7860.213978602152, 7887.290143887078, 4667.603253723438, 4718.575328220477, 4739.7630118493935, 4760.928586071212, 4774.331593576902, 3105.1305634422397, 3156.510740835174, 3180.3321302526265, 3191.69678880506, 3225.4355487789544, 1020.9693709188662, 1041.4896700616719, 1043.410473082706, 1062.0759938853248, 1076.2950267574752, 10711.517981690842, 10717.9464102679, 10745.247832651796, 10772.515236814284, 10788.352698838095, 4170.311898536707, 4239.364095385717, 4252.638525725286, 4255.340422234559, 4303.440552728188, 8706.521141337287, 8710.346723995599, 8722.520261385558, 8723.956380218058, 8733.03936566977, 4737.95262047382, 4746.59653929413, 4755.643326750507, 4782.952170478251, 4802.903941921142, 4347.5652434756275, 4349.521552629209, 4357.172137293904, 4359.629431498295, 4416.138852923649, 3404.472306792451, 3421.8289085545625, 3430.6740859618294, 3434.587849458031, 3458.602260739997, 1035.3529044347283, 1038.2939601071344, 1045.6340280901622, 1050.4380156616173, 1063.9734006649742, 1014.3761586624173, 1021.8058568871891, 1085.696005118568, 1157.5254145800182, 1313.481174935895, 7351.742689005859, 7447.329740323288, 7455.813604659927, 7468.813279668052, 7529.058867641545, 1012.7265638277623, 1036.7770929250248, 1110.3448965110624, 1118.189312748251, 1164.1152723929874, 5749.3963133871175, 5831.766729330864, 5833.183354330312, 5864.530837532987, 5881.852953676107, 9211.815763684688, 9308.720738377859, 9312.767180820398, 9411.717648470556, 9430.62277508892, 9252.074792520694, 9307.022762609964, 9377.953110234404, 9384.67153649619, 9428.387154834914, 6956.686949087303, 7061.470389720689, 7194.352508274281, 7231.638418079075, 7290.3438690518105, 7188.784336469915, 7281.126264848041, 7291.197968223385, 7321.926780732125, 7339.376153027052, 8173.427860049977, 8196.959015204886, 8238.670453182045, 8390.244877961013, 8419.158084191777, 8193.262606365455, 8363.916360836558, 8384.58077096155, 8385.454945428528, 8499.915000849913, 6797.592144471348, 6831.6242606657115, 6894.069300644349, 6897.7240910365035, 6913.89629155553, 7484.401247900264, 7528.473006889465, 7561.432892532972, 7572.848543028998, 7589.924100759143, 6812.14848143982, 6937.826554336182, 6966.547174433848, 6996.895046574204, 7079.646017698991, 6251.9687401562705, 6451.41937225652, 6546.7888440638635, 6929.648718499844, 7110.0, 7145.321194486515, 7175.712971481291, 7190.676419561237, 7193.676284567103, 7216.278372162742, 6488.513361497812, 6543.280239173782, 6564.37638424368, 6571.145751052332, 6575.835604109936, 6497.285298617243, 6551.901721474277, 6561.80314590563, 6562.77030303937, 6612.140421745143], "unit": "ms", "name": "mootools.html", "value": 4488.361276538524}, {"lowerIsBetter": false, "replicates": [335.54868701596354, 341.9401604719175, 343.07541176529264, 349.325801203677, 351.9401701710709, 6257.843553911149, 6292.779752708656, 6297.433231009209, 6310.053491976206, 6475.579087359319, 6267.185265915436, 6272.278687950887, 6297.622142671443, 6304.180456540655, 6322.462590679786, 4767.332573439721, 4778.402699662543, 4781.569658730714, 4789.449213340476, 4791.257355109946, 4745.0, 4796.280557916306, 4796.496367881375, 4797.160496913044, 4804.423469183703, 4594.770261486929, 4705.976470117662, 4706.505816889228, 4713.363695901044, 4721.079389519045, 4688.921548043952, 4703.2474804031535, 4710.481846996828, 4714.127886341038, 4714.57568818808, 4076.694247931417, 4087.264292427362, 4089.754614723126, 4092.4884389451317, 4095.7337773044655, 5882.411758824083, 5893.58744887858, 5928.851778705523, 5951.2858456985, 5962.07587823888, 5413.377461591928, 5462.289902312714, 5486.1222204447495, 5497.945020549783, 5498.3127109111365, 6632.436242919358, 6656.667166641697, 6660.167479065117, 6667.899981500282, 6678.332166783282, 4451.1765323415275, 4487.41663583732, 4487.596116349511, 4502.909941801178, 4504.774761261924, 6770.187577490733, 6840.486963477759, 6903.965480172617, 6917.757878474229, 6928.757493487704, 4628.83799067031, 4634.907301854011, 4640.582347588733, 4643.257078867433, 4648.907021859543, 4681.250999840009, 4682.4381074271305, 4683.695559788671, 4684.718916864999, 4685.906281874343, 5447.264619276426, 5455.972720136374, 5457.045017121988, 5475.835724928259, 5478.835634930959, 6478.060681201199, 6661.700223489955, 6669.699863506057, 6710.865782684416, 6770.69531871067, 1612.3711752416566, 1635.9918200408922, 1641.6142206581444, 1646.300322362991, 1650.9587260318588, 1059.5443959097508, 1077.6605369308643, 1080.8974845657385, 1085.9022687958122, 1088.542812018954, 6309.526785491106, 6328.588641738273, 6357.205349331333, 6371.076193951851, 6389.361063893573, 6757.93242067573, 6768.7292508299115, 6768.932310676831, 6791.117154769947, 6809.0, 6179.783707570214, 6318.273398559225, 6322.462590679752, 6333.46165575922, 6345.936540634627, 3714.9442758358646, 3718.795466249382, 3720.330340538729, 3727.4781530585738, 3735.2716220337315, 6972.2330543640155, 7046.837271850088, 7050.753223637251, 7075.787726368218, 7084.539504932163, 6804.11546498952, 6937.271586483447, 6971.5468494547695, 6986.895196572055, 6987.790366289019, 7001.229864714877, 7028.859422811515, 7041.683124259421, 7046.43628509718, 7046.894296585555, 6733.966330168318, 6755.966220168868, 6760.898586521304, 6765.120534330702, 6797.0823938767635, 6562.261000834878, 6614.570052946543, 6665.0, 6693.531452798257, 6695.4308883745425, 7034.226235114031, 7036.612986285599, 7037.894431583428, 7038.683259253244, 7038.788836334918, 4572.062727140995, 4582.9312560310955, 4600.861974140781, 4605.723656580616, 4618.330342100444, 6710.295418981132, 6718.596884186964, 6756.797296081126, 6773.695183716646, 6873.518853680194, 6645.534812563074, 6696.799096026932, 6715.832104197239, 6734.292899245509, 6757.189137303555, 6704.229013663491, 6711.4966377520905, 6721.966390168018, 6722.327767223239, 6736.157980252468, 6398.232212134573, 6520.250171230369, 6521.054447105048, 6521.184851893513, 6534.83662908412, 6701.1623547056615, 6701.497387696039, 6727.562708423937, 6741.797746067626, 6746.9325306746305, 6504.869902602016, 6539.149910511603, 6559.376859198369, 6559.4752419807255, 6595.0], "unit": "ms", "name": "prototype.html", "value": 4968.950285094634}, {"lowerIsBetter": false, "replicates": [852.6205838401905, 859.2953777902121, 860.5826174305465, 867.1285358214993, 869.9217070463659, 13784.862151378496, 14114.858851411484, 14124.71750564988, 14136.787948180772, 14158.079724817879, 12859.935700321485, 12934.676633084178, 12956.0, 12974.15667981583, 13027.153235039716, 792.5957761541626, 806.4637016384127, 808.7169490678274, 817.6238930092135, 832.1304237072274, 816.8652172391548, 817.9222973817477, 822.6709316273509, 823.3865770001357, 823.851706692795, 868.9044205137429, 869.256785448442, 871.4335681806845, 871.559862269553, 874.7200895713374, 864.8270345930777, 865.4417900454234, 869.4739682492096, 870.3602851903846, 870.634333579898, 630.6783540394385, 631.2235949781748, 633.1800318587441, 634.3973225435808, 636.4749082007316, 14092.788608170886, 14109.435622575085, 14113.858861411358, 14154.646133846632, 14225.07537010091, 11737.765244695143, 11869.703257418547, 12192.085593580518, 12456.75086498265, 13019.088663793538, 10004.199664026934, 10051.748706282402, 10255.333403328834, 11537.0, 11619.76760464786, 3591.6947059499976, 3642.016655503026, 3683.0, 3737.0470530014672, 3754.1177823211524, 49298.0, 49363.75318123422, 49368.75315623435, 49390.75304623454, 49473.0, 9849.310548261554, 10179.796404072025, 10253.74365640865, 10400.323978941344, 10745.979131982449, 17739.73390399145, 17753.644927101643, 17774.46676599704, 17796.644067118585, 17815.376461823773, 6415.454686351619, 6608.8347791305605, 6612.041254018237, 6633.2371777246235, 6804.931950680529, 4156.916861662749, 4195.035141917376, 4204.285271503852, 4213.91572168561, 4236.68224883135, 3080.7997480163717, 3102.681360421812, 3103.736182424474, 3107.3163903941095, 3112.066380085965, 552.9695866727288, 572.5076434266527, 578.0808514462026, 580.3847921203537, 587.3216435017562, 504.85106893466514, 534.0333995468214, 590.1973316289842, 601.1433706967554, 714.1002337055244, 7943.563104029334, 7947.3642108631175, 8393.706220282262, 8430.026517310647, 8595.613197406132, 651.3779340729592, 659.9274079851212, 683.1597135523334, 689.9517033807585, 697.5152269172978, 3885.9611403886165, 4011.4183443400543, 4188.5811418857875, 4279.495534936905, 4301.612854843017, 60332.0, 60718.69640651769, 60951.0, 60999.39000610026, 61425.38574614286, 46767.29849052267, 48362.51637483651, 52816.207756883676, 54013.45986540163, 55468.44531554633, 44770.3284450727, 45183.322250166275, 45557.772211139396, 45902.31146532805, 49466.50533494691, 8260.215279548433, 8481.830363392573, 8663.610137543952, 8738.956305218433, 8854.424462409923, 33749.325013500085, 34212.82893585516, 34764.652353477155, 34774.82612586921, 35274.47088293729, 42595.787021064694, 44365.77817110894, 46622.53377466182, 46751.53248467608, 47064.529354706014, 10121.089101980562, 10180.338278011906, 10570.894291056991, 10578.259521833706, 10924.453777310944, 11378.146639001943, 11770.234934729559, 11807.704807379541, 11842.52629894829, 11949.940250298692, 11057.557697692324, 11079.556817727524, 11242.718932026764, 11250.099992000783, 11576.486072819309, 10170.644027459004, 10396.16830653561, 10409.323393979366, 10459.110975567162, 10461.790764184825, 11133.832992504957, 11481.081513479068, 11516.53933842637, 11822.231554948901, 11942.880571194177, 9489.098535639103, 9651.083147101013, 9697.175740062174, 9751.317407781387, 9921.305508614329, 8781.604827782892, 9011.459312441275, 9329.253659707343, 9403.059694030542, 10139.239557033105], "unit": "ms", "name": "yui.html", "value": 6305.805213523625}], "name": "dromaeo_css", "value": 7053.931208802851}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 110.0, 112.0, 112.0, 123.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 157.0, 170.0, 127.0, 151.0, 147.0, 126.0, 169.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 163.0, 164.0, 161.0, 163.0, 165.0, 179.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 73.0, 75.0, 74.0, 141.0, 72.0, 73.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 139.0, 91.0, 91.0, 91.0, 134.0, 90.0, 90.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 111.0, 109.0, 110.0, 110.0, 110.0, 119.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 63.0, 63.0], "unit": "ms", "name": "json-parse-financial", "value": 65.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 71.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 87.0, 86.0, 86.0, 86.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [118.0, 113.0, 128.0, 125.0, 123.0, 128.0, 125.0, 118.0, 120.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [140.0, 159.0, 151.0, 151.0, 150.0, 142.0, 150.0, 151.0, 158.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 67.0, 67.0, 67.0, 69.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1521.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6451880072884], "unit": "score", "name": "Richards", "value": 213.11817399999993}, {"lowerIsBetter": false, "replicates": [192.75250578257518], "unit": "score", "name": "DeltaBlue", "value": 343.0201839999999}, {"lowerIsBetter": false, "replicates": [285.5511136493432], "unit": "score", "name": "Encrypt", "value": 932.1658620000004}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25175.0], "unit": "score", "name": "RegExp", "value": 36.186097318768596}, {"lowerIsBetter": false, "replicates": [611.0436893203884], "unit": "score", "name": "Splay", "value": 133.3636226415094}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21373.240807871865}]} 04:27:51 INFO - RETURN: dromaeo_css: 7053.93 04:27:51 INFO - RETURN: kraken: 1521.90 04:27:51 INFO - RETURN: v8_7: 21373.24 04:27:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21373.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1521.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7053.93"}}} 04:27:51 INFO - Return code: 0 04:27:51 INFO - # TBPL SUCCESS # 04:27:51 INFO - Running post-action listener: _resource_record_post_action 04:27:51 INFO - Running post-run listener: _resource_record_post_run 04:27:52 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 508686336; Read time: 0; Write time: 339312 04:27:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 221323264; Read time: 0; Write time: 197828 04:27:52 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 286846976; Read time: 0; Write time: 141460 04:27:52 INFO - Running post-run listener: _upload_blobber_files 04:27:52 INFO - Blob upload gear active. 04:27:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:27:52 INFO - Copying logs to upload dir... 04:27:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.512787 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-21 04:27:51.832454) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:27:51.836635) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010044 build_url: 'https://queue.taskcluster.net/v1/task/_LjMqi_cQG6SVypm14JQiQ/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-21 04:27:51.888153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:27:51.888481) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448107216.554567-1812300540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:27:51.938971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:27:51.939300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:27:51.939639) ========= ========= Total master_lag: 0.29 =========