builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1448021079.15 results: success (0) buildid: 20151120023014 builduid: 33e0591bbada4cafb5cd9b25d7a11734 revision: c1bac7e467ed12be20caf4a58a7bac4cdf252119 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.145794) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.146335) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.146625) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006569 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.167529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.167851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.180951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.181231) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.230389) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.230682) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.231051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.231520) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 04:04:39-- 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% 28.2M=0s 2015-11-20 04:04:39 (28.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164498 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.409751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.410077) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.459275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:39.459583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1bac7e467ed12be20caf4a58a7bac4cdf252119 --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 c1bac7e467ed12be20caf4a58a7bac4cdf252119 --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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 04:04:39,881 truncating revision to first 12 chars 2015-11-20 04:04:39,881 Setting DEBUG logging. 2015-11-20 04:04:39,881 attempt 1/10 2015-11-20 04:04:39,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1bac7e467ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 04:04:40,119 unpacking tar archive at: fx-team-c1bac7e467ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:40.017310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:40.017690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:40.026835) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:40.027107) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 04:04:40.027556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-20 04:04:40.027902) ========= /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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:04:40 INFO - MultiFileLogger online at 20151120 04:04:40 in /builds/slave/test-pgo 04:04:40 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:04:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:04:40 INFO - {'append_to_log': False, 04:04:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:04:40 INFO - 'blob_upload_branch': 'Fx-Team', 04:04:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:04:40 INFO - 'branch': 'Fx-Team', 04:04:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:40 INFO - 'config_files': ('talos/linux_config.py',), 04:04:40 INFO - 'default_actions': ('clobber', 04:04:40 INFO - 'read-buildbot-config', 04:04:40 INFO - 'download-and-extract', 04:04:40 INFO - 'populate-webroot', 04:04:40 INFO - 'create-virtualenv', 04:04:40 INFO - 'install', 04:04:40 INFO - 'run-tests'), 04:04:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:40 INFO - 'download_minidump_stackwalk': True, 04:04:40 INFO - 'download_symbols': 'ondemand', 04:04:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:40 INFO - 'installer_path': 'installer.exe', 04:04:40 INFO - 'log_level': 'info', 04:04:40 INFO - 'log_name': 'talos', 04:04:40 INFO - 'log_to_console': True, 04:04:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:04:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:04:40 INFO - 'opt_config_files': (), 04:04:40 INFO - 'pip_index': False, 04:04:40 INFO - 'sps_profile': False, 04:04:40 INFO - 'sps_profile_interval': 0, 04:04:40 INFO - 'suite': 'dromaeojs-e10s', 04:04:40 INFO - 'system_bits': '64', 04:04:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:40 INFO - 'title': 'talos-linux64-ix-004', 04:04:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:40 INFO - 'use_talos_json': True, 04:04:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:04:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:40 INFO - 'work_dir': 'build'} 04:04:40 INFO - ##### 04:04:40 INFO - ##### Running clobber step. 04:04:40 INFO - ##### 04:04:40 INFO - Running pre-action listener: _resource_record_pre_action 04:04:40 INFO - Running main action method: clobber 04:04:40 INFO - rmtree: /builds/slave/test-pgo/build 04:04:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:04:40 INFO - Running post-action listener: _resource_record_post_action 04:04:40 INFO - ##### 04:04:40 INFO - ##### Running read-buildbot-config step. 04:04:40 INFO - ##### 04:04:40 INFO - Running pre-action listener: _resource_record_pre_action 04:04:40 INFO - Running main action method: read_buildbot_config 04:04:40 INFO - Using buildbot properties: 04:04:40 INFO - { 04:04:40 INFO - "properties": { 04:04:40 INFO - "buildnumber": 66, 04:04:40 INFO - "product": "firefox", 04:04:40 INFO - "script_repo_revision": "production", 04:04:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:04:40 INFO - "repository": "", 04:04:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:04:40 INFO - "buildid": "20151120023014", 04:04:40 INFO - "slavename": "talos-linux64-ix-004", 04:04:40 INFO - "pgo_build": "True", 04:04:40 INFO - "basedir": "/builds/slave/test-pgo", 04:04:40 INFO - "project": "", 04:04:40 INFO - "platform": "ubuntu64_hw", 04:04:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:04:40 INFO - "slavebuilddir": "test", 04:04:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:04:40 INFO - "branch": "fx-team", 04:04:40 INFO - "repo_path": "integration/fx-team", 04:04:40 INFO - "stage_platform": "linux64-pgo", 04:04:40 INFO - "builduid": "33e0591bbada4cafb5cd9b25d7a11734", 04:04:40 INFO - "revision": "c1bac7e467ed12be20caf4a58a7bac4cdf252119" 04:04:40 INFO - }, 04:04:40 INFO - "sourcestamp": { 04:04:40 INFO - "repository": "", 04:04:40 INFO - "hasPatch": false, 04:04:40 INFO - "project": "", 04:04:40 INFO - "branch": "fx-team-linux64-pgo-talos", 04:04:40 INFO - "changes": [ 04:04:40 INFO - { 04:04:40 INFO - "category": null, 04:04:40 INFO - "files": [ 04:04:40 INFO - { 04:04:40 INFO - "url": null, 04:04:40 INFO - "name": "https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:04:40 INFO - } 04:04:40 INFO - ], 04:04:40 INFO - "repository": "", 04:04:40 INFO - "rev": "c1bac7e467ed12be20caf4a58a7bac4cdf252119", 04:04:40 INFO - "who": "sendchange", 04:04:40 INFO - "when": 1448020942, 04:04:40 INFO - "number": 6688095, 04:04:40 INFO - "comments": "", 04:04:40 INFO - "project": "", 04:04:40 INFO - "at": "Fri 20 Nov 2015 04:02:22", 04:04:40 INFO - "branch": "fx-team-linux64-pgo-talos", 04:04:40 INFO - "revlink": "", 04:04:40 INFO - "properties": [ 04:04:40 INFO - [ 04:04:40 INFO - "buildid", 04:04:40 INFO - "20151120023014", 04:04:40 INFO - "Change" 04:04:40 INFO - ], 04:04:40 INFO - [ 04:04:40 INFO - "builduid", 04:04:40 INFO - "33e0591bbada4cafb5cd9b25d7a11734", 04:04:40 INFO - "Change" 04:04:40 INFO - ], 04:04:40 INFO - [ 04:04:40 INFO - "pgo_build", 04:04:40 INFO - "True", 04:04:40 INFO - "Change" 04:04:40 INFO - ] 04:04:40 INFO - ], 04:04:40 INFO - "revision": "c1bac7e467ed12be20caf4a58a7bac4cdf252119" 04:04:40 INFO - } 04:04:40 INFO - ], 04:04:40 INFO - "revision": "c1bac7e467ed12be20caf4a58a7bac4cdf252119" 04:04:40 INFO - } 04:04:40 INFO - } 04:04:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:04:40 INFO - Running post-action listener: _resource_record_post_action 04:04:40 INFO - ##### 04:04:40 INFO - ##### Running download-and-extract step. 04:04:40 INFO - ##### 04:04:40 INFO - Running pre-action listener: _resource_record_pre_action 04:04:40 INFO - Running main action method: download_and_extract 04:04:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:04: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:04:40 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:04:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json 04:04:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json 04:04:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:04:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:04:48 INFO - Downloaded 1302 bytes. 04:04:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:04:48 INFO - Using the following test package requirements: 04:04:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'jsshell-linux-x86_64.zip'], 04:04:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:04:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:04:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:48 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:04:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:04:53 INFO - Downloaded 22523565 bytes. 04:04:53 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:04:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:53 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:04:54 INFO - Return code: 0 04:04:54 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:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:54 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:05:05 INFO - Downloaded 22523565 bytes. 04:05:05 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:05:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:05 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:05:07 INFO - Return code: 0 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:07 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:05:13 INFO - Downloaded 11130997 bytes. 04:05:13 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:05:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:13 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:05:13 INFO - Return code: 0 04:05: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:05:13 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/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:05:16 INFO - Downloaded 57350611 bytes. 04:05:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:16 INFO - mkdir: /builds/slave/test-pgo/properties 04:05:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:05:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:05:16 INFO - Contents: 04:05:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:16 INFO - Running post-action listener: _resource_record_post_action 04:05:16 INFO - Running post-action listener: set_extra_try_arguments 04:05:16 INFO - ##### 04:05:16 INFO - ##### Running populate-webroot step. 04:05:16 INFO - ##### 04:05:16 INFO - Running pre-action listener: _resource_record_pre_action 04:05:16 INFO - Running main action method: populate_webroot 04:05:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:05:16 INFO - '../fennec_ids.txt'], 04:05:16 INFO - 'tests': ['tcheck2']}, 04:05:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:16 INFO - '--tppagecycles', 04:05:16 INFO - '7'], 04:05:16 INFO - 'tests': ['tsvgm']}}, 04:05:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'tests': ['damp', 'tps']}, 04:05:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['damp', 'tps']}, 04:05:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:16 INFO - 'other': {'tests': ['a11yr', 04:05:16 INFO - 'ts_paint', 04:05:16 INFO - 'tpaint', 04:05:16 INFO - 'sessionrestore', 04:05:16 INFO - 'sessionrestore_no_auto_restore']}, 04:05:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['a11yr', 04:05:16 INFO - 'ts_paint', 04:05:16 INFO - 'tpaint', 04:05:16 INFO - 'sessionrestore', 04:05:16 INFO - 'sessionrestore_no_auto_restore']}, 04:05:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['a11yr', 04:05:16 INFO - 'ts_paint', 04:05:16 INFO - 'tpaint', 04:05:16 INFO - 'sessionrestore', 04:05:16 INFO - 'sessionrestore_no_auto_restore']}, 04:05:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['a11yr', 04:05:16 INFO - 'ts_paint', 04:05:16 INFO - 'tpaint', 04:05:16 INFO - 'sessionrestore', 04:05:16 INFO - 'sessionrestore_no_auto_restore']}, 04:05:16 INFO - 'other_l64': {'tests': ['a11yr', 04:05:16 INFO - 'ts_paint', 04:05:16 INFO - 'tpaint', 04:05:16 INFO - 'sessionrestore', 04:05:16 INFO - 'sessionrestore_no_auto_restore']}, 04:05:16 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:16 INFO - 'ts_paint', 04:05:16 INFO - 'tpaint', 04:05:16 INFO - 'sessionrestore', 04:05:16 INFO - 'sessionrestore_no_auto_restore']}, 04:05:16 INFO - 'svgr': {'tests': ['tsvgx', 04:05:16 INFO - 'tsvgr_opacity', 04:05:16 INFO - 'tart', 04:05:16 INFO - 'tscrollx', 04:05:16 INFO - 'cart']}, 04:05:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['tsvgx', 04:05:16 INFO - 'tsvgr_opacity', 04:05:16 INFO - 'tart', 04:05:16 INFO - 'tscrollx', 04:05:16 INFO - 'cart']}, 04:05:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'tests': ['tp5o']}, 04:05:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'talos_options': ['--e10s'], 04:05:16 INFO - 'tests': ['tp5o']}, 04:05:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'talos_options': ['--xperf_path', 04:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:16 INFO - 'tests': ['tp5n']}, 04:05:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:16 INFO - 'talos_options': ['--e10s', 04:05:16 INFO - '--xperf_path', 04:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:16 INFO - 'tests': ['tp5n']}}, 04:05:16 INFO - 'talos.zip': {'path': '', 04:05:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:16 INFO - Running post-action listener: _resource_record_post_action 04:05:16 INFO - ##### 04:05:16 INFO - ##### Running create-virtualenv step. 04:05:16 INFO - ##### 04:05:16 INFO - Running pre-action listener: _resource_record_pre_action 04:05:16 INFO - Running main action method: create_virtualenv 04:05:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:05:16 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:05:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:05:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:16 INFO - Using real prefix '/usr' 04:05:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:05:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:18 INFO - Installing pip.................done. 04:05:18 INFO - Return code: 0 04:05:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:05:18 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:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 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:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:18 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:05:18 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:05:19 INFO - Using env: {'DISPLAY': ':0', 04:05:19 INFO - 'HOME': '/home/cltbld', 04:05:19 INFO - 'LANG': 'en_US.UTF-8', 04:05:19 INFO - 'LANGUAGE': 'en_US:en', 04:05:19 INFO - 'LOGNAME': 'cltbld', 04:05:19 INFO - 'MAIL': '/var/mail/cltbld', 04:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:19 INFO - 'MOZ_NO_REMOTE': '1', 04:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:19 INFO - 'NO_EM_RESTART': '1', 04:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:19 INFO - 'SHELL': '/bin/bash', 04:05:19 INFO - 'SHLVL': '1', 04:05:19 INFO - 'TERM': 'linux', 04:05:19 INFO - 'TMOUT': '86400', 04:05:19 INFO - 'USER': 'cltbld', 04:05:19 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:19 INFO - '_': '/tools/buildbot/bin/python'} 04:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:19 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:05:19 INFO - Cleaning up... 04:05:19 INFO - Return code: 0 04:05:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:05: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:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:19 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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:19 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:05:19 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:05:19 INFO - Using env: {'DISPLAY': ':0', 04:05:19 INFO - 'HOME': '/home/cltbld', 04:05:19 INFO - 'LANG': 'en_US.UTF-8', 04:05:19 INFO - 'LANGUAGE': 'en_US:en', 04:05:19 INFO - 'LOGNAME': 'cltbld', 04:05:19 INFO - 'MAIL': '/var/mail/cltbld', 04:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:19 INFO - 'MOZ_NO_REMOTE': '1', 04:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:19 INFO - 'NO_EM_RESTART': '1', 04:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:19 INFO - 'SHELL': '/bin/bash', 04:05:19 INFO - 'SHLVL': '1', 04:05:19 INFO - 'TERM': 'linux', 04:05:19 INFO - 'TMOUT': '86400', 04:05:19 INFO - 'USER': 'cltbld', 04:05:19 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:19 INFO - '_': '/tools/buildbot/bin/python'} 04:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:19 INFO - Downloading/unpacking psutil>=0.7.1 04:05:19 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:05:19 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:05:19 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:05:19 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:05:19 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:05:19 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:05:21 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:05:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:05:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:21 INFO - Installing collected packages: psutil 04:05:21 INFO - Running setup.py install for psutil 04:05:21 INFO - building 'psutil._psutil_linux' extension 04:05:21 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:05:21 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:05:21 INFO - building 'psutil._psutil_posix' extension 04:05:21 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:05:21 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:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:21 INFO - Successfully installed psutil 04:05:21 INFO - Cleaning up... 04:05:21 INFO - Return code: 0 04:05:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:21 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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:21 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:05:21 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:05:21 INFO - Using env: {'DISPLAY': ':0', 04:05:21 INFO - 'HOME': '/home/cltbld', 04:05:21 INFO - 'LANG': 'en_US.UTF-8', 04:05:21 INFO - 'LANGUAGE': 'en_US:en', 04:05:21 INFO - 'LOGNAME': 'cltbld', 04:05:21 INFO - 'MAIL': '/var/mail/cltbld', 04:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:21 INFO - 'MOZ_NO_REMOTE': '1', 04:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:21 INFO - 'NO_EM_RESTART': '1', 04:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:21 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:21 INFO - 'SHELL': '/bin/bash', 04:05:21 INFO - 'SHLVL': '1', 04:05:21 INFO - 'TERM': 'linux', 04:05:21 INFO - 'TMOUT': '86400', 04:05:21 INFO - 'USER': 'cltbld', 04:05:21 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:21 INFO - '_': '/tools/buildbot/bin/python'} 04:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05:21 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:05:21 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:05:21 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:05:21 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:05:21 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:05:21 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:05:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:05:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:05:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:23 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:05:23 INFO - Installing collected packages: mozsystemmonitor 04:05:23 INFO - Running setup.py install for mozsystemmonitor 04:05:23 INFO - Successfully installed mozsystemmonitor 04:05:23 INFO - Cleaning up... 04:05:23 INFO - Return code: 0 04:05:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:05:23 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:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 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:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:23 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:05:23 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:05:23 INFO - Using env: {'DISPLAY': ':0', 04:05:23 INFO - 'HOME': '/home/cltbld', 04:05:23 INFO - 'LANG': 'en_US.UTF-8', 04:05:23 INFO - 'LANGUAGE': 'en_US:en', 04:05:23 INFO - 'LOGNAME': 'cltbld', 04:05:23 INFO - 'MAIL': '/var/mail/cltbld', 04:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:23 INFO - 'MOZ_NO_REMOTE': '1', 04:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:23 INFO - 'NO_EM_RESTART': '1', 04:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:23 INFO - 'SHELL': '/bin/bash', 04:05:23 INFO - 'SHLVL': '1', 04:05:23 INFO - 'TERM': 'linux', 04:05:23 INFO - 'TMOUT': '86400', 04:05:23 INFO - 'USER': 'cltbld', 04:05:23 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:23 INFO - '_': '/tools/buildbot/bin/python'} 04:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:24 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:05:24 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:05:24 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:05:24 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:05:24 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:05:24 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:05:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:05:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:25 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:05:25 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:05:25 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:05:25 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:05:25 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:05:25 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:05:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:05:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:05:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:26 INFO - Downloading docopt-0.6.1.tar.gz 04:05:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:05:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:26 INFO - Running setup.py install for blobuploader 04:05:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:05:26 INFO - Running setup.py install for requests 04:05:26 INFO - Running setup.py install for docopt 04:05:26 INFO - Successfully installed blobuploader requests docopt 04:05:26 INFO - Cleaning up... 04:05:26 INFO - Return code: 0 04:05:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:26 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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:26 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:05:26 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:05:26 INFO - Using env: {'DISPLAY': ':0', 04:05:26 INFO - 'HOME': '/home/cltbld', 04:05:26 INFO - 'LANG': 'en_US.UTF-8', 04:05:26 INFO - 'LANGUAGE': 'en_US:en', 04:05:26 INFO - 'LOGNAME': 'cltbld', 04:05:26 INFO - 'MAIL': '/var/mail/cltbld', 04:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:26 INFO - 'MOZ_NO_REMOTE': '1', 04:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:26 INFO - 'NO_EM_RESTART': '1', 04:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:26 INFO - 'SHELL': '/bin/bash', 04:05:26 INFO - 'SHLVL': '1', 04:05:26 INFO - 'TERM': 'linux', 04:05:26 INFO - 'TMOUT': '86400', 04:05:26 INFO - 'USER': 'cltbld', 04:05:26 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:26 INFO - '_': '/tools/buildbot/bin/python'} 04:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:27 INFO - Running setup.py (path:/tmp/pip-rk0QLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:27 INFO - Running setup.py (path:/tmp/pip-MXuuKR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:27 INFO - Running setup.py (path:/tmp/pip-ICwG2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:27 INFO - Running setup.py (path:/tmp/pip-lN9fkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:27 INFO - Running setup.py (path:/tmp/pip-rPCceN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:27 INFO - Running setup.py (path:/tmp/pip-LAEpDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:27 INFO - Running setup.py (path:/tmp/pip-PA5wfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:27 INFO - Running setup.py (path:/tmp/pip-vSrF_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:27 INFO - Running setup.py (path:/tmp/pip-aJSduA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:27 INFO - Running setup.py (path:/tmp/pip-lG7DAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:27 INFO - Running setup.py (path:/tmp/pip-EOmxqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:27 INFO - Running setup.py (path:/tmp/pip-kwSm1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:28 INFO - Running setup.py (path:/tmp/pip-ISnEva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:28 INFO - Running setup.py (path:/tmp/pip-keiTQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:28 INFO - Running setup.py (path:/tmp/pip-QKGBbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:28 INFO - Running setup.py (path:/tmp/pip-1TVAbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:28 INFO - Running setup.py (path:/tmp/pip-LKMYHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:28 INFO - Running setup.py install for manifestparser 04:05:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:05:28 INFO - Running setup.py install for mozcrash 04:05:28 INFO - Running setup.py install for mozdebug 04:05:28 INFO - Running setup.py install for mozdevice 04:05:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:05:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:05:28 INFO - Running setup.py install for mozfile 04:05:28 INFO - Running setup.py install for mozhttpd 04:05:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for mozinfo 04:05:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for mozInstall 04:05:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for mozleak 04:05:29 INFO - Running setup.py install for mozlog 04:05:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for moznetwork 04:05:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for mozprocess 04:05:29 INFO - Running setup.py install for mozprofile 04:05:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for mozrunner 04:05:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:05:29 INFO - Running setup.py install for mozscreenshot 04:05:29 INFO - Running setup.py install for moztest 04:05:30 INFO - Running setup.py install for mozversion 04:05:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:05:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:30 INFO - Cleaning up... 04:05:30 INFO - Return code: 0 04:05:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:30 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:05:30 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:05:30 INFO - Using env: {'DISPLAY': ':0', 04:05:30 INFO - 'HOME': '/home/cltbld', 04:05:30 INFO - 'LANG': 'en_US.UTF-8', 04:05:30 INFO - 'LANGUAGE': 'en_US:en', 04:05:30 INFO - 'LOGNAME': 'cltbld', 04:05:30 INFO - 'MAIL': '/var/mail/cltbld', 04:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:30 INFO - 'MOZ_NO_REMOTE': '1', 04:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:30 INFO - 'NO_EM_RESTART': '1', 04:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:30 INFO - 'SHELL': '/bin/bash', 04:05:30 INFO - 'SHLVL': '1', 04:05:30 INFO - 'TERM': 'linux', 04:05:30 INFO - 'TMOUT': '86400', 04:05:30 INFO - 'USER': 'cltbld', 04:05:30 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:30 INFO - '_': '/tools/buildbot/bin/python'} 04:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:30 INFO - Running setup.py (path:/tmp/pip-yNzuWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:30 INFO - Running setup.py (path:/tmp/pip-70HLt1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:30 INFO - Running setup.py (path:/tmp/pip-GsemJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:30 INFO - Running setup.py (path:/tmp/pip-kN1HyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:30 INFO - Running setup.py (path:/tmp/pip-uf_70o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:30 INFO - Running setup.py (path:/tmp/pip-udaduA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:30 INFO - Running setup.py (path:/tmp/pip-mb8Kkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:30 INFO - Running setup.py (path:/tmp/pip-ry6cHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:30 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:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:30 INFO - Running setup.py (path:/tmp/pip-ddpOPh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:31 INFO - Running setup.py (path:/tmp/pip-25WG9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:31 INFO - Running setup.py (path:/tmp/pip-qClQWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:31 INFO - Running setup.py (path:/tmp/pip-bsq4Hk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:31 INFO - Running setup.py (path:/tmp/pip-NRWe_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:31 INFO - Running setup.py (path:/tmp/pip-YWviGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:31 INFO - Running setup.py (path:/tmp/pip-3dmx3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:31 INFO - Running setup.py (path:/tmp/pip-ba5rwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:31 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:05:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:31 INFO - Running setup.py (path:/tmp/pip-J6dy37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:31 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:05:31 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:05:31 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:05:31 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:05:31 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:05:31 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:05:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:31 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:05:31 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:05:31 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:05:31 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:05:31 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:05:31 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:05:33 INFO - Downloading blessings-1.5.1.tar.gz 04:05:33 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:05:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:33 INFO - Installing collected packages: blessings 04:05:33 INFO - Running setup.py install for blessings 04:05:33 INFO - Successfully installed blessings 04:05:33 INFO - Cleaning up... 04:05:33 INFO - Return code: 0 04:05:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:05:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:33 INFO - Reading from file tmpfile_stdout 04:05:33 INFO - Current package versions: 04:05:33 INFO - argparse == 1.2.1 04:05:33 INFO - blessings == 1.5.1 04:05:33 INFO - blobuploader == 1.2.4 04:05:33 INFO - docopt == 0.6.1 04:05:33 INFO - manifestparser == 1.1 04:05:33 INFO - mozInstall == 1.12 04:05:33 INFO - mozcrash == 0.16 04:05:33 INFO - mozdebug == 0.1 04:05:33 INFO - mozdevice == 0.47 04:05:33 INFO - mozfile == 1.2 04:05:33 INFO - mozhttpd == 0.7 04:05:33 INFO - mozinfo == 0.9 04:05:33 INFO - mozleak == 0.1 04:05:33 INFO - mozlog == 3.0 04:05:33 INFO - moznetwork == 0.27 04:05:33 INFO - mozprocess == 0.22 04:05:33 INFO - mozprofile == 0.27 04:05:33 INFO - mozrunner == 6.11 04:05:33 INFO - mozscreenshot == 0.1 04:05:33 INFO - mozsystemmonitor == 0.0 04:05:33 INFO - moztest == 0.7 04:05:33 INFO - mozversion == 1.4 04:05:33 INFO - psutil == 3.1.1 04:05:33 INFO - requests == 1.2.3 04:05:33 INFO - wsgiref == 0.1.2 04:05:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:33 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 0x7f13d0c52c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', '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:05:33 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:05:33 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:05:33 INFO - Using env: {'DISPLAY': ':0', 04:05:33 INFO - 'HOME': '/home/cltbld', 04:05:33 INFO - 'LANG': 'en_US.UTF-8', 04:05:33 INFO - 'LANGUAGE': 'en_US:en', 04:05:33 INFO - 'LOGNAME': 'cltbld', 04:05:33 INFO - 'MAIL': '/var/mail/cltbld', 04:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:33 INFO - 'MOZ_NO_REMOTE': '1', 04:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:33 INFO - 'NO_EM_RESTART': '1', 04:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:33 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:33 INFO - 'SHELL': '/bin/bash', 04:05:33 INFO - 'SHLVL': '1', 04:05:33 INFO - 'TERM': 'linux', 04:05:33 INFO - 'TMOUT': '86400', 04:05:33 INFO - 'USER': 'cltbld', 04:05:33 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:33 INFO - '_': '/tools/buildbot/bin/python'} 04:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 INFO - Cleaning up... 04:05:33 INFO - Return code: 0 04:05:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - Running post-action listener: _start_resource_monitoring 04:05:33 INFO - Starting resource monitoring. 04:05:33 INFO - ##### 04:05:33 INFO - ##### Running install step. 04:05:33 INFO - ##### 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: install 04:05:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:34 INFO - Reading from file tmpfile_stdout 04:05:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:05:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:05:34 INFO - Reading from file tmpfile_stdout 04:05:34 INFO - Output received: 04:05:34 INFO - Usage: mozinstall [options] installer 04:05:34 INFO - Options: 04:05:34 INFO - -h, --help show this help message and exit 04:05:34 INFO - -d DEST, --destination=DEST 04:05:34 INFO - Directory to install application into. [default: 04:05:34 INFO - "/builds/slave/test-pgo"] 04:05:34 INFO - --app=APP Application being installed. [default: firefox] 04:05:34 INFO - mkdir: /builds/slave/test-pgo/build/application 04:05:34 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:05:34 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:05:48 INFO - Reading from file tmpfile_stdout 04:05:48 INFO - Output received: 04:05:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:05:48 INFO - Running post-action listener: _resource_record_post_action 04:05:48 INFO - ##### 04:05:48 INFO - ##### Running run-tests step. 04:05:48 INFO - ##### 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: run_tests 04:05:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:05:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:05:48 INFO - Python 2.7.3 04:05:48 INFO - Return code: 0 04:05:48 INFO - grabbing minidump binary from tooltool 04:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:48 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 0x1dd3d70>, '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 0x1dd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:05:48 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:05:48 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:05:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:48 INFO - Return code: 0 04:05:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:05:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:05:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:05:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:48 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/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:05:48 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/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 04:05:48 INFO - Using env: {'DISPLAY': ':0', 04:05:48 INFO - 'HOME': '/home/cltbld', 04:05:48 INFO - 'LANG': 'en_US.UTF-8', 04:05:48 INFO - 'LANGUAGE': 'en_US:en', 04:05:48 INFO - 'LOGNAME': 'cltbld', 04:05:48 INFO - 'MAIL': '/var/mail/cltbld', 04:05:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:48 INFO - 'MOZ_NO_REMOTE': '1', 04:05:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:48 INFO - 'NO_EM_RESTART': '1', 04:05:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:05:48 INFO - 'SHELL': '/bin/bash', 04:05:48 INFO - 'SHLVL': '1', 04:05:48 INFO - 'TERM': 'linux', 04:05:48 INFO - 'TMOUT': '86400', 04:05:48 INFO - 'USER': 'cltbld', 04:05:48 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198', 04:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:48 INFO - '_': '/tools/buildbot/bin/python'} 04:05:48 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/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 04:05:48 INFO - mozversion INFO | application_buildid: 20151120023014 04:05:48 INFO - mozversion INFO | application_changeset: c1bac7e467ed12be20caf4a58a7bac4cdf252119 04:05:48 INFO - mozversion INFO | application_display_name: Nightly 04:05:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:48 INFO - mozversion INFO | application_name: Firefox 04:05:48 INFO - mozversion INFO | application_remotingname: firefox 04:05:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:05:48 INFO - mozversion INFO | application_vendor: Mozilla 04:05:48 INFO - mozversion INFO | application_version: 45.0a1 04:05:48 INFO - mozversion INFO | platform_buildid: 20151120023014 04:05:48 INFO - mozversion INFO | platform_changeset: c1bac7e467ed12be20caf4a58a7bac4cdf252119 04:05:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:05:48 INFO - mozversion INFO | platform_version: 45.0a1 04:05:48 INFO - 2015-11-20 04:05:48,955 DEBUG : using testdate: 1448021148 04:05:48 INFO - 2015-11-20 04:05:48,955 DEBUG : actual date: 1448021148 04:05:48 INFO - 2015-11-20 04:05:48,964 INFO : starting webserver on 'localhost:42063' 04:05:48 INFO - 2015-11-20 04:05:48,965 INFO : Starting test suite talos-linux64-ix-004.e 04:05:48 INFO - 2015-11-20 04:05:48,965 INFO : Starting test dromaeo_css 04:05:48 INFO - 2015-11-20 04:05:48,965 DEBUG : operating with platform_type : linux_ 04:05:48 INFO - 2015-11-20 04:05:48,966 INFO : Initialising browser for dromaeo_css test... 04:05:48 INFO - 2015-11-20 04:05:48,980 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMxzgaa/profile http://localhost:42063/getInfo.html 04:05:54 INFO - 2015-11-20 04:05:54,029 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:54 INFO - 2015-11-20 04:05:54,029 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:54 INFO - 2015-11-20 04:05:54,029 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:05:54 INFO - 2015-11-20 04:05:54,029 DEBUG : BROWSER_OUTPUT: __metrics 04:05:55 INFO - 2015-11-20 04:05:55,074 INFO : Browser initialized. 04:05:55 INFO - 2015-11-20 04:05:55,075 INFO : Running cycle 1/1 for dromaeo_css test... 04:05:55 INFO - 2015-11-20 04:05:55,075 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMxzgaa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:06 INFO - 2015-11-20 04:06:06,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 141996032 04:06:06 INFO - 2015-11-20 04:06:06,898 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-20 04:06:56,511 DEBUG : BROWSER_OUTPUT: 1448021216510 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:09:05 INFO - 2015-11-20 04:09:05,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42063/tests/dromaeo/cssquery-ext.html) 04:09:06 INFO - 2015-11-20 04:09:06,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 146550784 04:09:06 INFO - 2015-11-20 04:09:06,642 DEBUG : BROWSER_OUTPUT: 04:12:08 INFO - 2015-11-20 04:12:08,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/dromaeo/cssquery-ext.html (next: http://localhost:42063/tests/dromaeo/cssquery-jquery.html) 04:12:09 INFO - 2015-11-20 04:12:09,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 142372864 04:12:09 INFO - 2015-11-20 04:12:09,169 DEBUG : BROWSER_OUTPUT: 04:15:10 INFO - 2015-11-20 04:15:10,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42063/tests/dromaeo/cssquery-mootools.html) 04:15:11 INFO - 2015-11-20 04:15:11,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 04:15:11 INFO - 2015-11-20 04:15:11,442 DEBUG : BROWSER_OUTPUT: 04:18:13 INFO - 2015-11-20 04:18:13,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42063/tests/dromaeo/cssquery-prototype.html) 04:18:13 INFO - 2015-11-20 04:18:13,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 141291520 04:18:13 INFO - 2015-11-20 04:18:13,735 DEBUG : BROWSER_OUTPUT: 04:21:16 INFO - 2015-11-20 04:21:16,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42063/tests/dromaeo/cssquery-yui.html) 04:21:16 INFO - 2015-11-20 04:21:16,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 142016512 04:21:16 INFO - 2015-11-20 04:21:16,681 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/dromaeo/cssquery-yui.html (next: http://localhost:42063/tests/dromaeo/cssquery-dojo.html) 04:24:19 INFO - 2015-11-20 04:24:19,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 144691200 04:24:19 INFO - 2015-11-20 04:24:19,373 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,375 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:24:19 INFO - 2015-11-20 04:24:19,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:24:19 INFO - 2015-11-20 04:24:19,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:24:19 INFO - 2015-11-20 04:24:19,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:24:19 INFO - 2015-11-20 04:24:19,379 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3226.4515032444483;3267.2811981364107;3279.065466342093;3315.4695248760195;3319.618243901952;5264.631475796696;5411.945880541193;5441.075017247068;5462.999999999995;5467.398586155519;5342.252084708134;5454.072807622703;5469.097598896187;5498.972505137479;5539.058360078786;4856.3686720726255;4886.071646387193;4887.828925987591;4927.6797008194535;4989.3604827899;4996.375453068366;5008.474110218429;5086.491350864921;5096.51583099605;5119.513646203604;4833.130036593412;4963.851084467472;4965.801367945278;4971.955889263259;5084.415292241384;4963.826266080706;4991.051700176991;4993.051320249141;5029.723365214912;5054.317667114966;4787.8563643090765;4955.677880937727;4983.202687569971;4985.950140498585;5057.797688092472;5076.314697515825;5163.406208286057;5189.714565698885;5192.532672059533;5202.297689811865;5944.762209511614;6018.8194354169445;6021.488173505258;6028.728707208186;6033.185519954794;5749.856253593652;6031;6068.089786532011;6070.180525629028;6071;5482.533984611313;5568.749406276727;5661.943380566224;5691.459311365414;5702.8289151325525;6004.819855404257;6039.365866584033;6050.818475445743;6057.18228039209;6060.787872424444;5553.944460555424;5824.388439213822;5834.183214349994;5835.679037652885;5859.2382990211;5766.077427611562;5880.558958078162;5904.940950590525;5909.734061967221;5917.171595976567;5740.339860916049;5764.193012978187;5764.827055188351;5797.043487824461;5814.825555233349;5646.6047376684055;5799.3620701722775;5807.912881306784;5810.709464526757;5862.208601838697;4431.423914891108;4452.844150454718;4453.732776033448;4487.753173575485;4535.682502224879;3988.082740969593;4017.2367250222364;4061.472008638858;4062.8171732272117;4080.2451546464;5347.893042139135;5424.647397919122;5493.917591236134;5591.30108736408;5630.943690563124;5931.73307201177;5978.282606087298;5997.70011499432;6005.219321488266;6010.789622363196;5552.08390615552;5626.606137570413;5635.943640563624;5647.689377084218;5652.576056795675;5014.147594908874;5046;5117.2068329409;5135.563477104413;5192.480751924777;5986.73059712314;6038.516918646497;6098.190188918898;6106.642687876592;6107.46191531438;5928;6025.0661147522205;6025.126356678345;6041;6056.878862422815;5929.822105336847;6037.547183961308;6162.938370616236;6197.380261973766;6217.4715149212825;5772;5829.358770535153;5840.503557197686;5873.853153671193;5912.793052243151;5902.468777810018;5924.851878703067;5929.466348028698;5938.435848594377;5950.880982380415;5583.609147359808;5694.174344720075;5800.883982320414;5805.10020946754;5807.8548036299435;5716.485516303553;5817.040188368872;5826.592138550261;5828.300603927556;5873.676947767743;5686.57350698691;5712.942870571407;5726.570507211893;5732.799352022659;5746.252987111816;5699;5779.36426993022;5832.94167058324;5833.095870140135;5840.678762667924;5599.468050535193;5614.7192640367;5748.907707535554;5762.654240745569;5794.913076303943 04:24:19 INFO - 2015-11-20 04:24:19,380 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.8055691545388;599.4485073732166;601.1133577972494;605.6124080588421;625.4808508937582;28462.43075138496;28877;39362.606373936214;39763;39784.40323395151;43028.354574681405;43421.7828910855;43661.56338436615;43663.90840228988;43757.34363984535;8590.48457092575;8736.301095912311;8748.125187481264;8758.781030474225;8760.8685869712;8539.188777066169;8678.956605216965;8687.131286871325;8694.39139260252;8698.521581313025;8601.5699215039;8669.21977022068;8675.522846243453;8677.088905664908;8677.869831952527;8612.39713220075;8636.697715579956;8667.089955554702;8670.1763332483;8676.219140277342;8537.103604121601;8623.267022303111;8649.221570058726;8649.264812490946;8672.913270867273;38688.613113868785;39318.803405982784;39348;39386.60613393858;39411;3191.505316675919;3268.8038717677014;3308.669133086696;3339.9499007514905;3390.3219356128875;29091.418171636662;29482.85258573715;29697.257568560744;29707.702922970926;30465.93369232066;3760.2291530236234;3842.9423558646645;3864.3932991996594;3909.902252443683;4015.5984401559904;262463;264026;264209.9999999981;264920;265302;57058.42941570531;57375.426245737006;57434.13848792271;57452;57464.71267643635;53010.20484692733;53793.46206537963;59168.40831591715;65644;66516.66741666358;15137.091774493345;15269;15341.539753807403;15416.61458463525;15446.768298475532;11124;11198.832017519744;11269.943650281695;11272.098232141409;11281.548738050386;18733.81266187348;18893.244270229312;18911.62176756457;18918.716219256723;18992.52518687044;7532.209118042636;7870.173631768696;7874.7243846466245;7888.171741967126;7948.403869709795;864.883240762489;868.0321441592579;965.358036905464;1028.6554004408606;1057.1120258982337;28357.858210708815;28390.574141387897;28399.85800071028;28520.156956837036;28530.286742831595;996.6013594562088;1021.3871676993745;1046.4453839464943;1070.7804899995638;1105.662772854271;14914.254287285592;14974.62563435901;15207.923960380127;15576.688466230838;15609.68780624404;320037;320889.76885809354;322349;324864;325398;52387.47612523902;52445.7377713109;52678.209826852624;52727;52936.735316323175;1347.8584748601452;1370.766969615168;1376.3393571085935;1377.6211541825878;1378.0904602962198;27791.86104069467;28401.857990709916;28909.421811564072;28971.13086607405;29073.12780616585;45489;45938.77030614825;45980;46143;46271.305930410395;310097;311887;312264;312977;314428;29944.700552994193;31620.683793162694;31700.841495792374;31845;32222.677773221967;39044.6095539041;39267.80366098151;39823;39972.60027399689;40187.19625607413;33016.50475242825;33342.666573333954;33773.83113084419;33983.4902476468;34181.145471363416;33735.3252934935;34804.477932831534;35593.69220673368;36396.27207455889;36723.44914826333;35026.474602881484;35171.82414087913;35735.498515103696;35881.46177807283;35916.82041589775;30975.380492389577;31598;32891.50662740013;33391.83304083464;33543.16142096467;24810;24906.377340566632;25232.864521096228;25237;25477 04:24:19 INFO - 2015-11-20 04:24:19,382 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.72481051995226;361.8100497238949;363.8199091449733;366.3753300622439;367.5203858964052;16375.754363684538;16770;17339.219735111918;17597.91201043993;18119.909400453012;13223.404946777395;13236.933815330935;13604.727905441885;13690.383932723027;16191.514254572381;4829.372181616385;4945.505449455044;4950.3069570260195;4951.059298733229;4952.727599981999;4834.661573689843;4860.198067318888;4868.294097355882;4870.853874383774;4892.584130348924;5023.799048038074;5114.105031619451;5163.380394352683;5172.40517340505;5258.395284542288;5127.158711989243;5157.071727089123;5166.793328266865;5179.611529135311;5941.881162376728;5332.706701131437;5357.758900849432;5373.925214956985;5374.4894235048;5383.515483606455;12623.368831558386;12660.55688050923;13250.337483125804;13328.733425331438;13332.866706329974;1970.5369238229005;2001.3395579458743;2074.1703318672503;2148.785121487854;2223.7998580127705;9856.260780441424;10029.648962286285;13178.802317965143;13327.73344533104;13401.061925665208;1885.9815699522242;1893.9337569633533;1920.7022911448748;1934.6711059119984;1957.4029920874127;60102;62856;63478.36521634771;63756.68121659362;63960.04059939151;9972.750681232883;10189.286749927582;10223.642172524074;10240.695843435316;10260.897391025994;13123.146995445266;13188.20870747739;13251.13867598603;13305.334733263491;13317;7814.726484573012;8013.959930200312;8036.276735093753;8106.027276726712;8119.59402029908;7869.606519673994;7907.406944479187;8007.199280072063;8034.558099304594;8040.437169398086;4473.977630111829;4551.180787458289;4568.5862253230025;4586.334981427674;4587.243104887723;1752.1502071495315;1839.383806424836;1846.5660569766094;1868.4768264885854;1873.7845147807905;879.9968036438465;883.4081165619051;927.248928368024;1049.354646892171;1072.4959269143646;16521.504354869372;17062;17226.224819883137;17416.431273518603;17482.737758933625;907.7912080221454;912.3841407050214;917.4678686361895;937.1331518345503;947.4457442396138;9582.137607615348;9908.554115064839;10017.749556261006;10053.145482634058;10132;539028;541606;552070;588802;589225;81726.18273817304;83422.16577834265;85105.57447212849;86651.56674216589;88636;1112.671761830262;1141.0757286597882;1143.1597775634903;1158.652404278713;1167.346286079815;14737;15454.613634659223;15677.137757423452;15703.685926281181;16058.518244452685;31366.843165784026;31706.04881853548;31987;32689.019329420156;33097;38812.223755525294;39571.208575828896;40259.597404026754;40900.79549602352;41141.382879256234;9495.952520237632;9692.273079518924;9999.900000999896;10016.248781341283;10100.090991810772;11753.823692644446;11785.528578857093;17047.232874520923;17883.552911177325;17918.820811791717;13973.371198295898;14545.563633091024;14720.116792992454;14801.111933284037;14951.177685227416;13525.729485410433;13759.587212383645;13806.93096534511;13947.372368243656;13965;13855.584332470042;13893.930530347689;14464.566063018126;14662;15015.924920375328;9515.524223788645;9527.190188834027;9571.090746379083;9657.082577155159;9737.951310243403;10160.390376577428;10502.527386267484;13084.542041028899;14584.124952502883;14982 04:24:19 INFO - 2015-11-20 04:24:19,385 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1452.8329242137154;1504.3982407037183;1587.5951632333754;1622.1402656592004;1736.696078186318;7232.566046037242;7406.185319614845;7454.366378857803;7470.813229669254;7614.73348432805;7229.602371869558;7259.854802903938;7299.416046716263;7310.926890731091;7342.706291748337;2268.8298377621704;2296.7818057284617;2303.1823702585593;2307.3885420363617;2309.399556115405;2307.8384513084093;2335.4278201840575;2338.4037070546988;2340.789328960393;2356;2240.574290884727;2296.7243930728337;2305.4697419593504;2310.1914329984456;2325.6278995360744;2205.2832829330373;2258.0854753824647;2306.4925716342464;2308.2382813671447;2312.7918487336137;2257.413072601119;2297.5634629420356;2297.9655305170436;2299.7470278269543;2302.82728795341;7385.66764495599;7388.298111679382;7456.3289303962365;7461.403087752967;7472.402207823361;4643.930341044887;4714.4106986626675;4750.809967601326;4769.713817170981;4775.522447755231;3042.7413669838093;3084.90745277642;3154.810711357326;3199.6640352762856;3207.5188721691698;1091.6397588795678;1097.4896673046992;1113.799516087104;1125.4260327233087;1145.8395824584481;9827.852582211273;9870.506474676238;9872.506374681308;9877.25920555954;9885;4017.116234428421;4097.836086556564;4104.794760261975;4114.650254728322;4172.561881002512;8116.715914942949;8163.795905102301;8178.46839955401;8201.42590018693;8203.71287004952;4534.9319760203625;4540.409746732904;4544.772761361919;4555.544445555484;4569.383133276965;4175.791210439465;4184.058586817941;4186.372044193396;4213.241616509058;4227.133437645275;3374.7300215982664;3461.9268026911236;3470.6008808986785;3477.5826900771563;3478.721702263813;1027.9691609251734;1029.912457441111;1036.9429681367446;1037.9740506487246;1040.8386700061503;1065.680295911239;1071.5927947379946;1110.9611163609236;1232.4885172653428;1349.0489205110373;6695.230048544479;6712.93287067123;6751.831204219934;6779.2881747416795;6903.6203008835;1059.4861492176287;1059.7668512927144;1061.3631820907394;1069.9350254009835;1079.8866119057386;5309.097453432925;5337.532178650902;5344.545713614309;5355;5356.491133342326;8573.571321433903;8754.299656027502;8812.515311657791;8863.64545418176;8935.776605584782;8738.344624153215;8748.34387420946;8776.736697899074;8787.077356877437;8812.383133180616;6635.435987940982;6669.599824010575;6824.249332573413;6830.112085428962;6878.621675807779;6774.762883299061;6794.830129246809;6834.658267086526;6880.277570854988;6892.241853396223;7739.535627862347;7830.060392752906;7833.37333013369;7896.960515197387;7973.641186146753;7863.84272314562;7912.28789408956;7923.920760792318;7925.484843485155;8112.472689275178;6306.211723534559;6626.469882409299;6632;6666.066750654815;6684.532082754161;7046.682899269647;7054.717811287491;7129;7139.643017848983;7144.714211431485;6517.543771936109;6525.2822189558165;6570.047343135314;6687.331266873273;6729.663516824237;6414.679266036773;6639.900401493885;6656.068150459037;6694.698738556874;6745.696443660146;6622.304658011032;6695.765648202289;6793.150856142982;6795.218549866829;6846.5892046477375;6217.440430361289;6223.937760622517;6226;6245.313015568375;6258.593191442542;6322.620642761449;6331.176946996861;6334.714937827716;6382.585131966407;6453.709583068867 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.39042894077465;345.0779160078364;346.49065873166444;346.8751249550163;351.6465951718524;6272.466840318572;6319.146915166451;6336.7465301388;6364.904526432101;6427.2929977702415;6259.217597800275;6297.307296197415;6339.714712837922;6352.301246862841;6355.269144048436;4795.96886669366;4820.542048505386;4822.469528351896;4825.372701548794;4829.203181475053;4800.983586893513;4801.063792560452;4810.446798618152;4822.373091498118;4834.274858771178;4651.744154071542;4743.359646447737;4747.1692453820615;4748.7863046163;4776.785044672998;4748.0978614063215;4759.333693282926;4771.8091276348905;4776.116418462579;4781.617470602343;4135.400366946806;4136.131412403399;4136.420901073852;4142.606452387018;4144.046869220066;6008.068749343859;6074.96962515189;6078.240219972504;6080.361562036011;6085.2697676278685;5428.83713488596;5562.582806289544;5579.776808927638;5583.274174357348;5601.439856014406;6726.293739157416;6739;6749.898751518731;6769.05233267343;6791.2869148739655;4593.219152744042;4594.1271158479785;4597.60920321773;4598.885027874297;4605.102005109005;6774.796756097325;6931.341522555349;6979.965100174467;7002.439804815603;7048.400885924702;4641.303804429295;4705.882352941204;4721.4570324413135;4726.810927562928;4735.579326202125;4782.593479554277;4788.545088216614;4790.4969978152485;4795.304680821261;4797.376341075638;5548.722563871871;5555.194496797942;5567.109262517978;5580.944190558123;5581.6371935824045;6605.966970165118;6760.628165450948;6780.966095169591;6796.558223715443;6804.591724496546;1620.651559914624;1658.3781082094215;1670.8329167083436;1690.7125788615965;1691.6785810695928;1090.9181811364178;1121.7083558274744;1127.8872112788656;1128.0637071230858;1134.880837512066;6332.176817013758;6346.809595712136;6369.745210191633;6404.039394090831;6478.190226221723;6918.411934985583;6924.930750692429;6951.548149370275;6956.130483689539;6956.495661561834;6377.17096777416;6408.231012278463;6451.387118223761;6455.096286519891;6462.806115816533;3793.905152371213;3833.1950290438763;3833.616638336144;3835.079580900564;3838.539375274929;7275.345218930322;7286.271372862671;7290.927090729131;7303.379212766974;7334.156571994182;7061.752838650623;7215.665101956155;7254.310840470147;7257.673404696696;7259.274072592804;7294.854102917806;7298.817529561803;7313.89029164563;7317.158526769384;7326.706931722778;6980.860382792417;7012.929870701431;7048;7054;7064.682089305891;6723.26044135135;6950.478714096362;6954.061201737701;6965.79102626922;6987.196472405739;7276.4178865689555;7279.1265048194555;7313.378362839218;7326.487145899736;7334.156571994289;4703.341532185428;4743.715377077387;4759.048190361872;4761.214399624162;4767.928481072856;6805;6850.828729281808;6957.686904089429;7048.048513450619;7063.646817658993;6830.931690683228;6851.725930962705;6865.313468653095;6867.107276054081;6867.175938887365;6833.760818371333;6836.316368363124;6836.42762164695;6838.521303508706;6848.794536163923;6514.902276465762;6654.268030516542;6719.193696756421;6732.899006514808;6733.696983635846;6890.552114112566;6891.655417229219;6900.6204658744255;6903.102596662402;6907.93092069093;6625.734970601122;6706.195256569243;6711.228208756055;6718.496112791658;6722.19333679942 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: |5;yui.html;825.8761185822126;832.6169961817563;845.5180547088158;846.0946786937975;847.4957400346799;12871.09902306839;13138.277394743285;13205.207687538754;13226.40481178348;13355.998300127492;13042.73914521709;13153.934230328836;13256.403461844217;13262.867371326283;13306.800397994013;816.9999999999985;834.1450013735939;835.031363618203;835.302522393802;835.4694768821812;827.0488937721608;834.8330333933208;837.7863644770575;843.0431460292551;843.0515669871395;857.3012994409536;865.4807115730574;866.8829707989404;868.8436081505326;869.443556124081;857.5540718826206;860.6987554355987;863.7279257034014;864.1013346120028;865.6191275838611;632.8892443822313;634.4955760170675;635.6345101566618;636.5098873867142;637.073058699591;14109.506167284198;14173.645658858508;14194.290285485788;14209.50266740659;14251.57245282643;11870.287782732978;12056.397180140957;12101.69745756363;12123.117144895623;12480.687982800502;9685.661001864972;9895.604175832957;9998.70003899877;10181.28730988831;10599.894001059967;3511.280187561569;3621.8551257949653;3621.9275614487565;3643.0710168907026;3705.221903400289;46646.53353466456;47055.529444705455;47077.529224708;47168.52831471676;47294;9813.27409934261;9879.407235565888;9954.402735835729;10101.646442374482;10135.239857010607;17821;17834.91082544579;17838.732419013726;17846.286148554173;17871.821281787015;7397.741079062207;7435.814104647319;7450.813729656802;7493.3630641395;7558.281963213486;4199.454070970815;4217.1776503581505;4232.640225580799;4263.381809637585;4364.9960509083085;3078.569000339954;3087.830169340663;3088.722015018614;3089.9845500772353;3098.752099832008;550.4468009650276;568.1874918866062;571.794154104522;573.0372973404637;573.9339975902741;652.6149571752688;655.6885479397248;665.9400653941168;691.5193940211504;718.5437247347971;8039.261509698509;8468.872966905501;8511.95744021276;8653.134686531297;8722.781930451789;648.4164252173082;650.391883588846;661.1702313596405;673.7406098651957;733.5561984999106;3910.2570511602703;4042.9797851010558;4244.8514301999285;4268.466441694788;4439.66702497314;57058.00296989585;57461.712691436274;57469.71265143731;57630.13554796681;57654.13518797221;50964.74517627462;52133.218001730005;52447;52488.47511524836;52640;44573.55426445759;44781.55218447839;45901;46426.767866159775;47610;8557.44376615518;8825.735227943173;9364.297677674065;9482.908942352233;9493.145616894513;35282.1179470505;35995.28009439849;36326.27347453089;37149.44275835919;37832;41617;45047;45551;45817.77091114523;45841.77079114583;11028.28316159447;11106;11293.604723834625;11421.885781142082;11440;12172.57395991136;12225.266484010988;12419.19275247106;12866.356682165668;12937.935310323388;11390.829137562778;11637.127215458706;11713;11720.531178752753;11763.117766167743;11083.72290692739;11167.553297867995;11275.379854108103;11450;11732.237404568676;11147.275427097213;11203.383813890314;11562.248453850472;11612.129090318429;11651.533938642699;9957;10150.390976541432;10256.768628703849;10296.794064118825;10464.058234758604;9375.531223438937;9850.556724947251;9860;9874.605015799287;10119.544620491948 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,299 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: __startTimestamp1448022259374__endTimestamp 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,387 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:24:19 INFO - 2015-11-20 04:24:19,388 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:24:19 INFO - 2015-11-20 04:24:19,388 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,388 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5471.60 Median:5702.83 stddev:627.29 (11.0%) stddev-sans-first:603.98 04:24:19 INFO - 2015-11-20 04:24:19,389 DEBUG : BROWSER_OUTPUT: Values: 3226.5 3267.3 3279.1 3315.5 3319.6 5264.6 5411.9 5441.1 5463.0 5467.4 5342.3 5454.1 5469.1 5499.0 5539.1 4856.4 4886.1 4887.8 4927.7 4989.4 4996.4 5008.5 5086.5 5096.5 5119.5 4833.1 4963.9 4965.8 4972.0 5084.4 4963.8 4991.1 4993.1 5029.7 5054.3 4787.9 4955.7 4983.2 4986.0 5057.8 5076.3 5163.4 5189.7 5192.5 5202.3 5944.8 6018.8 6021.5 6028.7 6033.2 5749.9 6031.0 6068.1 6070.2 6071.0 5482.5 5568.7 5661.9 5691.5 5702.8 6004.8 6039.4 6050.8 6057.2 6060.8 5553.9 5824.4 5834.2 5835.7 5859.2 5766.1 5880.6 5904.9 5909.7 5917.2 5740.3 5764.2 5764.8 5797.0 5814.8 5646.6 5799.4 5807.9 5810.7 5862.2 4431.4 4452.8 4453.7 4487.8 4535.7 3988.1 4017.2 4061.5 4062.8 4080.2 5347.9 5424.6 5493.9 5591.3 5630.9 5931.7 5978.3 5997.7 6005.2 6010.8 5552.1 5626.6 5635.9 5647.7 5652.6 5014.1 5046.0 5117.2 5135.6 5192.5 5986.7 6038.5 6098.2 6106.6 6107.5 5928.0 6025.1 6025.1 6041.0 6056.9 5929.8 6037.5 6162.9 6197.4 6217.5 5772.0 5829.4 5840.5 5873.9 5912.8 5902.5 5924.9 5929.5 5938.4 5950.9 5583.6 5694.2 5800.9 5805.1 5807.9 5716.5 5817.0 5826.6 5828.3 5873.7 5686.6 5712.9 5726.6 5732.8 5746.3 5699.0 5779.4 5832.9 5833.1 5840.7 5599.5 5614.7 5748.9 5762.7 5794.9 04:24:19 INFO - 2015-11-20 04:24:19,389 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,389 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46553.77 Median:35099.15 stddev:78706.07 (224.2%) stddev-sans-first:78851.10 04:24:19 INFO - 2015-11-20 04:24:19,391 DEBUG : BROWSER_OUTPUT: Values: 557.8 599.4 601.1 605.6 625.5 28462.4 28877.0 39362.6 39763.0 39784.4 43028.4 43421.8 43661.6 43663.9 43757.3 8590.5 8736.3 8748.1 8758.8 8760.9 8539.2 8679.0 8687.1 8694.4 8698.5 8601.6 8669.2 8675.5 8677.1 8677.9 8612.4 8636.7 8667.1 8670.2 8676.2 8537.1 8623.3 8649.2 8649.3 8672.9 38688.6 39318.8 39348.0 39386.6 39411.0 3191.5 3268.8 3308.7 3339.9 3390.3 29091.4 29482.9 29697.3 29707.7 30465.9 3760.2 3842.9 3864.4 3909.9 4015.6 262463.0 264026.0 264210.0 264920.0 265302.0 57058.4 57375.4 57434.1 57452.0 57464.7 53010.2 53793.5 59168.4 65644.0 66516.7 15137.1 15269.0 15341.5 15416.6 15446.8 11124.0 11198.8 11269.9 11272.1 11281.5 18733.8 18893.2 18911.6 18918.7 18992.5 7532.2 7870.2 7874.7 7888.2 7948.4 864.9 868.0 965.4 1028.7 1057.1 28357.9 28390.6 28399.9 28520.2 28530.3 996.6 1021.4 1046.4 1070.8 1105.7 14914.3 14974.6 15207.9 15576.7 15609.7 320037.0 320889.8 322349.0 324864.0 325398.0 52387.5 52445.7 52678.2 52727.0 52936.7 1347.9 1370.8 1376.3 1377.6 1378.1 27791.9 28401.9 28909.4 28971.1 29073.1 45489.0 45938.8 45980.0 46143.0 46271.3 310097.0 311887.0 312264.0 312977.0 314428.0 29944.7 31620.7 31700.8 31845.0 32222.7 39044.6 39267.8 39823.0 39972.6 40187.2 33016.5 33342.7 33773.8 33983.5 34181.1 33735.3 34804.5 35593.7 36396.3 36723.4 35026.5 35171.8 35735.5 35881.5 35916.8 30975.4 31598.0 32891.5 33391.8 33543.2 24810.0 24906.4 25232.9 25237.0 25477.0 04:24:19 INFO - 2015-11-20 04:24:19,391 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,391 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29172.63 Median:31536.45 stddev:91989.40 (291.7%) stddev-sans-first:92222.01 04:24:19 INFO - 2015-11-20 04:24:19,391 DEBUG : BROWSER_OUTPUT: Values: 359.7 361.8 363.8 366.4 367.5 16375.8 16770.0 17339.2 17597.9 18119.9 13223.4 13236.9 13604.7 13690.4 16191.5 4829.4 4945.5 4950.3 4951.1 4952.7 4834.7 4860.2 4868.3 4870.9 4892.6 5023.8 5114.1 5163.4 5172.4 5258.4 5127.2 5157.1 5166.8 5179.6 5941.9 5332.7 5357.8 5373.9 5374.5 5383.5 12623.4 12660.6 13250.3 13328.7 13332.9 1970.5 2001.3 2074.2 2148.8 2223.8 9856.3 10029.6 13178.8 13327.7 13401.1 1886.0 1893.9 1920.7 1934.7 1957.4 60102.0 62856.0 63478.4 63756.7 63960.0 9972.8 10189.3 10223.6 10240.7 10260.9 13123.1 13188.2 13251.1 13305.3 13317.0 7814.7 8014.0 8036.3 8106.0 8119.6 7869.6 7907.4 8007.2 8034.6 8040.4 4474.0 4551.2 4568.6 4586.3 4587.2 1752.2 1839.4 1846.6 1868.5 1873.8 880.0 883.4 927.2 1049.4 1072.5 16521.5 17062.0 17226.2 17416.4 17482.7 907.8 912.4 917.5 937.1 947.4 9582.1 9908.6 10017.7 10053.1 10132.0 539028.0 541606.0 552070.0 588802.0 589225.0 81726.2 83422.2 85105.6 86651.6 88636.0 1112.7 1141.1 1143.2 1158.7 1167.3 14737.0 15454.6 15677.1 15703.7 16058.5 31366.8 31706.0 31987.0 32689.0 33097.0 38812.2 39571.2 40259.6 40900.8 41141.4 9496.0 9692.3 9999.9 10016.2 10100.1 11753.8 11785.5 17047.2 17883.6 17918.8 13973.4 14545.6 14720.1 14801.1 14951.2 13525.7 13759.6 13806.9 13947.4 13965.0 13855.6 13893.9 14464.6 14662.0 15015.9 9515.5 9527.2 9571.1 9657.1 9738.0 10160.4 10502.5 13084.5 14584.1 14982.0 04:24:19 INFO - 2015-11-20 04:24:19,392 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,392 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5199.25 Median:6314.42 stddev:2589.59 (41.0%) stddev-sans-first:2581.54 04:24:19 INFO - 2015-11-20 04:24:19,392 DEBUG : BROWSER_OUTPUT: Values: 1452.8 1504.4 1587.6 1622.1 1736.7 7232.6 7406.2 7454.4 7470.8 7614.7 7229.6 7259.9 7299.4 7310.9 7342.7 2268.8 2296.8 2303.2 2307.4 2309.4 2307.8 2335.4 2338.4 2340.8 2356.0 2240.6 2296.7 2305.5 2310.2 2325.6 2205.3 2258.1 2306.5 2308.2 2312.8 2257.4 2297.6 2298.0 2299.7 2302.8 7385.7 7388.3 7456.3 7461.4 7472.4 4643.9 4714.4 4750.8 4769.7 4775.5 3042.7 3084.9 3154.8 3199.7 3207.5 1091.6 1097.5 1113.8 1125.4 1145.8 9827.9 9870.5 9872.5 9877.3 9885.0 4017.1 4097.8 4104.8 4114.7 4172.6 8116.7 8163.8 8178.5 8201.4 8203.7 4534.9 4540.4 4544.8 4555.5 4569.4 4175.8 4184.1 4186.4 4213.2 4227.1 3374.7 3461.9 3470.6 3477.6 3478.7 1028.0 1029.9 1036.9 1038.0 1040.8 1065.7 1071.6 1111.0 1232.5 1349.0 6695.2 6712.9 6751.8 6779.3 6903.6 1059.5 1059.8 1061.4 1069.9 1079.9 5309.1 5337.5 5344.5 5355.0 5356.5 8573.6 8754.3 8812.5 8863.6 8935.8 8738.3 8748.3 8776.7 8787.1 8812.4 6635.4 6669.6 6824.2 6830.1 6878.6 6774.8 6794.8 6834.7 6880.3 6892.2 7739.5 7830.1 7833.4 7897.0 7973.6 7863.8 7912.3 7923.9 7925.5 8112.5 6306.2 6626.5 6632.0 6666.1 6684.5 7046.7 7054.7 7129.0 7139.6 7144.7 6517.5 6525.3 6570.0 6687.3 6729.7 6414.7 6639.9 6656.1 6694.7 6745.7 6622.3 6695.8 6793.2 6795.2 6846.6 6217.4 6223.9 6226.0 6245.3 6258.6 6322.6 6331.2 6334.7 6382.6 6453.7 04:24:19 INFO - 2015-11-20 04:24:19,392 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,392 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5642.04 Median:6367.32 stddev:1730.43 (27.2%) stddev-sans-first:1688.99 04:24:19 INFO - 2015-11-20 04:24:19,394 DEBUG : BROWSER_OUTPUT: Values: 344.4 345.1 346.5 346.9 351.6 6272.5 6319.1 6336.7 6364.9 6427.3 6259.2 6297.3 6339.7 6352.3 6355.3 4796.0 4820.5 4822.5 4825.4 4829.2 4801.0 4801.1 4810.4 4822.4 4834.3 4651.7 4743.4 4747.2 4748.8 4776.8 4748.1 4759.3 4771.8 4776.1 4781.6 4135.4 4136.1 4136.4 4142.6 4144.0 6008.1 6075.0 6078.2 6080.4 6085.3 5428.8 5562.6 5579.8 5583.3 5601.4 6726.3 6739.0 6749.9 6769.1 6791.3 4593.2 4594.1 4597.6 4598.9 4605.1 6774.8 6931.3 6980.0 7002.4 7048.4 4641.3 4705.9 4721.5 4726.8 4735.6 4782.6 4788.5 4790.5 4795.3 4797.4 5548.7 5555.2 5567.1 5580.9 5581.6 6606.0 6760.6 6781.0 6796.6 6804.6 1620.7 1658.4 1670.8 1690.7 1691.7 1090.9 1121.7 1127.9 1128.1 1134.9 6332.2 6346.8 6369.7 6404.0 6478.2 6918.4 6924.9 6951.5 6956.1 6956.5 6377.2 6408.2 6451.4 6455.1 6462.8 3793.9 3833.2 3833.6 3835.1 3838.5 7275.3 7286.3 7290.9 7303.4 7334.2 7061.8 7215.7 7254.3 7257.7 7259.3 7294.9 7298.8 7313.9 7317.2 7326.7 6980.9 7012.9 7048.0 7054.0 7064.7 6723.3 6950.5 6954.1 6965.8 6987.2 7276.4 7279.1 7313.4 7326.5 7334.2 4703.3 4743.7 4759.0 4761.2 4767.9 6805.0 6850.8 6957.7 7048.0 7063.6 6830.9 6851.7 6865.3 6867.1 6867.2 6833.8 6836.3 6836.4 6838.5 6848.8 6514.9 6654.3 6719.2 6732.9 6733.7 6890.6 6891.7 6900.6 6903.1 6907.9 6625.7 6706.2 6711.2 6718.5 6722.2 04:24:19 INFO - 2015-11-20 04:24:19,394 DEBUG : BROWSER_OUTPUT: 04:24:19 INFO - 2015-11-20 04:24:19,394 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13878.60 Median:45871.39 stddev:15956.54 (34.8%) stddev-sans-first:15971.19 04:24:19 INFO - 2015-11-20 04:24:19,394 DEBUG : BROWSER_OUTPUT: Values: 825.9 832.6 845.5 846.1 847.5 12871.1 13138.3 13205.2 13226.4 13356.0 13042.7 13153.9 13256.4 13262.9 13306.8 817.0 834.1 835.0 835.3 835.5 827.0 834.8 837.8 843.0 843.1 857.3 865.5 866.9 868.8 869.4 857.6 860.7 863.7 864.1 865.6 632.9 634.5 635.6 636.5 637.1 14109.5 14173.6 14194.3 14209.5 14251.6 11870.3 12056.4 12101.7 12123.1 12480.7 9685.7 9895.6 9998.7 10181.3 10599.9 3511.3 3621.9 3621.9 3643.1 3705.2 46646.5 47055.5 47077.5 47168.5 47294.0 9813.3 9879.4 9954.4 10101.6 10135.2 17821.0 17834.9 17838.7 17846.3 17871.8 7397.7 7435.8 7450.8 7493.4 7558.3 4199.5 4217.2 4232.6 4263.4 4365.0 3078.6 3087.8 3088.7 3090.0 3098.8 550.4 568.2 571.8 573.0 573.9 652.6 655.7 665.9 691.5 718.5 8039.3 8468.9 8512.0 8653.1 8722.8 648.4 650.4 661.2 673.7 733.6 3910.3 4043.0 4244.9 4268.5 4439.7 57058.0 57461.7 57469.7 57630.1 57654.1 50964.7 52133.2 52447.0 52488.5 52640.0 44573.6 44781.6 45901.0 46426.8 47610.0 8557.4 8825.7 9364.3 9482.9 9493.1 35282.1 35995.3 36326.3 37149.4 37832.0 41617.0 45047.0 45551.0 45817.8 45841.8 11028.3 11106.0 11293.6 11421.9 11440.0 12172.6 12225.3 12419.2 12866.4 12937.9 11390.8 11637.1 11713.0 11720.5 11763.1 11083.7 11167.6 11275.4 11450.0 11732.2 11147.3 11203.4 11562.2 11612.1 11651.5 9957.0 10150.4 10256.8 10296.8 10464.1 9375.5 9850.6 9860.0 9874.6 10119.5 04:24:19 INFO - 2015-11-20 04:24:19,394 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:24:19 INFO - 2015-11-20 04:24:19,394 DEBUG : BROWSER_OUTPUT: 04:24:20 INFO - 2015-11-20 04:24:20,090 INFO : Browser exited with error code: 0 04:24:20 INFO - 2015-11-20 04:24:20,111 INFO : Completed test dromaeo_css (00:18:31) 04:24:20 INFO - 2015-11-20 04:24:20,112 INFO : Starting test kraken 04:24:20 INFO - 2015-11-20 04:24:20,112 DEBUG : operating with platform_type : linux_ 04:24:20 INFO - 2015-11-20 04:24:20,112 INFO : Initialising browser for kraken test... 04:24:20 INFO - 2015-11-20 04:24:20,118 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9wuOyn/profile http://localhost:42063/getInfo.html 04:24:24 INFO - 2015-11-20 04:24:24,602 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:24:24 INFO - 2015-11-20 04:24:24,602 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:24:24 INFO - 2015-11-20 04:24:24,602 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:24:24 INFO - 2015-11-20 04:24:24,602 DEBUG : BROWSER_OUTPUT: __metrics 04:24:25 INFO - 2015-11-20 04:24:25,606 INFO : Browser initialized. 04:24:25 INFO - 2015-11-20 04:24:25,607 INFO : Running cycle 1/1 for kraken test... 04:24:25 INFO - 2015-11-20 04:24:25,607 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9wuOyn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:24:37 INFO - 2015-11-20 04:24:37,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 141004800 04:24:37 INFO - 2015-11-20 04:24:37,378 DEBUG : BROWSER_OUTPUT: 04:24:39 INFO - 2015-11-20 04:24:39,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42063/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:40 INFO - 2015-11-20 04:24:40,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 141643776 04:24:40 INFO - 2015-11-20 04:24:40,481 DEBUG : BROWSER_OUTPUT: 04:24:43 INFO - 2015-11-20 04:24:43,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42063/tests/kraken/driver.html?testName=audio-dft) 04:24:43 INFO - 2015-11-20 04:24:43,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 04:24:43 INFO - 2015-11-20 04:24:43,691 DEBUG : BROWSER_OUTPUT: 04:24:46 INFO - 2015-11-20 04:24:46,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42063/tests/kraken/driver.html?testName=audio-fft) 04:24:47 INFO - 2015-11-20 04:24:47,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 136712192 04:24:47 INFO - 2015-11-20 04:24:47,121 DEBUG : BROWSER_OUTPUT: 04:24:49 INFO - 2015-11-20 04:24:49,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42063/tests/kraken/driver.html?testName=audio-oscillator) 04:24:49 INFO - 2015-11-20 04:24:49,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 137412608 04:24:49 INFO - 2015-11-20 04:24:49,696 DEBUG : BROWSER_OUTPUT: 04:24:51 INFO - 2015-11-20 04:24:51,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:52 INFO - 2015-11-20 04:24:52,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 137854976 04:24:52 INFO - 2015-11-20 04:24:52,457 DEBUG : BROWSER_OUTPUT: 04:24:55 INFO - 2015-11-20 04:24:55,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42063/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:56 INFO - 2015-11-20 04:24:56,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 137953280 04:24:56 INFO - 2015-11-20 04:24:56,063 DEBUG : BROWSER_OUTPUT: 04:24:59 INFO - 2015-11-20 04:24:59,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42063/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:00 INFO - 2015-11-20 04:25:00,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 139128832 04:25:00 INFO - 2015-11-20 04:25:00,055 DEBUG : BROWSER_OUTPUT: 04:25:02 INFO - 2015-11-20 04:25:02,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42063/tests/kraken/driver.html?testName=json-parse-financial) 04:25:03 INFO - 2015-11-20 04:25:03,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 139440128 04:25:03 INFO - 2015-11-20 04:25:03,493 DEBUG : BROWSER_OUTPUT: 04:25:05 INFO - 2015-11-20 04:25:05,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:05 INFO - 2015-11-20 04:25:05,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 04:25:05 INFO - 2015-11-20 04:25:05,668 DEBUG : BROWSER_OUTPUT: 04:25:07 INFO - 2015-11-20 04:25:07,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:08 INFO - 2015-11-20 04:25:08,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 139853824 04:25:08 INFO - 2015-11-20 04:25:08,123 DEBUG : BROWSER_OUTPUT: 04:25:10 INFO - 2015-11-20 04:25:10,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:10 INFO - 2015-11-20 04:25:10,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 139784192 04:25:10 INFO - 2015-11-20 04:25:10,790 DEBUG : BROWSER_OUTPUT: 04:25:13 INFO - 2015-11-20 04:25:13,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:13 INFO - 2015-11-20 04:25:13,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 140242944 04:25:13 INFO - 2015-11-20 04:25:13,850 DEBUG : BROWSER_OUTPUT: 04:25:16 INFO - 2015-11-20 04:25:16,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:16 INFO - 2015-11-20 04:25:16,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 04:25:16 INFO - 2015-11-20 04:25:16,972 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42063/tests/kraken/driver.html?testName=ai-astar) 04:25:18 INFO - 2015-11-20 04:25:18,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 139247616 04:25:18 INFO - 2015-11-20 04:25:18,905 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,908 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;110;110;110;123;110;110;110;109 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;128;149;171;126;154;149;124;162;126 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;164;162;163;162;164;168;163 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;72;74;72;72;136;72;73;73 04:25:18 INFO - 2015-11-20 04:25:18,909 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;131;91;91;91;140;91;91;134 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;110;109;110;110;110 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;147;146;146;148;146;146;146 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;98;96;96;97;97 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;60;60;61;60;60;61;59;59 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;68;69;70;69;68;69 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;87;84;84;84;84;87;93;85 04:25:18 INFO - 2015-11-20 04:25:18,910 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;116;131;118;119;114;122;121;127;127 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;148;147;147;160;143;152;148;149;140 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;68;67;67;70;68;68;66;65 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,713 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:25:18 INFO - 2015-11-20 04:25:18,911 DEBUG : BROWSER_OUTPUT: __startTimestamp1448022318906__endTimestamp 04:25:18 INFO - 2015-11-20 04:25:18,912 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:25:18 INFO - 2015-11-20 04:25:18,915 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:25:18 INFO - 2015-11-20 04:25:18,915 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,916 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:4.59 (4.2%) stddev-sans-first:4.87 04:25:18 INFO - 2015-11-20 04:25:18,916 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 110.0 110.0 110.0 123.0 110.0 110.0 110.0 109.0 04:25:18 INFO - 2015-11-20 04:25:18,916 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,916 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.00 stddev:16.96 (11.2%) stddev-sans-first:17.68 04:25:18 INFO - 2015-11-20 04:25:18,917 DEBUG : BROWSER_OUTPUT: Values: 153.0 128.0 149.0 171.0 126.0 154.0 149.0 124.0 162.0 126.0 04:25:18 INFO - 2015-11-20 04:25:18,917 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,917 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.25 (1.4%) stddev-sans-first:2.29 04:25:18 INFO - 2015-11-20 04:25:18,917 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 164.0 162.0 163.0 162.0 164.0 168.0 163.0 04:25:18 INFO - 2015-11-20 04:25:18,918 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,918 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:73.00 stddev:20.04 (27.5%) stddev-sans-first:21.14 04:25:18 INFO - 2015-11-20 04:25:18,918 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 74.0 72.0 72.0 136.0 72.0 73.0 73.0 04:25:18 INFO - 2015-11-20 04:25:18,918 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,918 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:91.00 stddev:21.43 (23.6%) stddev-sans-first:22.20 04:25:18 INFO - 2015-11-20 04:25:18,919 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 131.0 91.0 91.0 91.0 140.0 91.0 91.0 134.0 04:25:18 INFO - 2015-11-20 04:25:18,919 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,919 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:25:18 INFO - 2015-11-20 04:25:18,919 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 04:25:18 INFO - 2015-11-20 04:25:18,920 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,920 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 04:25:18 INFO - 2015-11-20 04:25:18,920 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 147.0 146.0 146.0 148.0 146.0 146.0 146.0 04:25:18 INFO - 2015-11-20 04:25:18,920 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 97.0 97.0 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:0.95 (1.6%) stddev-sans-first:0.97 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 60.0 60.0 61.0 60.0 60.0 61.0 59.0 59.0 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 68.0 69.0 70.0 69.0 68.0 69.0 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:2.95 (3.5%) stddev-sans-first:2.99 04:25:18 INFO - 2015-11-20 04:25:18,921 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 87.0 84.0 84.0 84.0 84.0 87.0 93.0 85.0 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.50 stddev:5.36 (4.4%) stddev-sans-first:5.66 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: Values: 120.0 116.0 131.0 118.0 119.0 114.0 122.0 121.0 127.0 127.0 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:148.00 stddev:5.89 (4.0%) stddev-sans-first:5.61 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: Values: 140.0 148.0 147.0 147.0 160.0 143.0 152.0 148.0 149.0 140.0 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-11-20 04:25:18,922 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 04:25:18 INFO - 2015-11-20 04:25:18,923 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 68.0 67.0 67.0 70.0 68.0 68.0 66.0 65.0 04:25:18 INFO - 2015-11-20 04:25:18,923 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:25:18 INFO - 2015-11-20 04:25:18,923 DEBUG : BROWSER_OUTPUT: 04:25:20 INFO - 2015-11-20 04:25:20,046 INFO : Browser exited with error code: 0 04:25:20 INFO - 2015-11-20 04:25:20,096 INFO : Completed test kraken (00:00:59) 04:25:20 INFO - 2015-11-20 04:25:20,096 INFO : Starting test v8_7 04:25:20 INFO - 2015-11-20 04:25:20,096 DEBUG : operating with platform_type : linux_ 04:25:20 INFO - 2015-11-20 04:25:20,097 INFO : Initialising browser for v8_7 test... 04:25:20 INFO - 2015-11-20 04:25:20,102 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXa8E6i/profile http://localhost:42063/getInfo.html 04:25:24 INFO - 2015-11-20 04:25:24,704 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:25:24 INFO - 2015-11-20 04:25:24,704 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:25:24 INFO - 2015-11-20 04:25:24,704 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:25:24 INFO - 2015-11-20 04:25:24,704 DEBUG : BROWSER_OUTPUT: __metrics 04:25:25 INFO - 2015-11-20 04:25:25,742 INFO : Browser initialized. 04:25:25 INFO - 2015-11-20 04:25:25,742 INFO : Running cycle 1/1 for v8_7 test... 04:25:25 INFO - 2015-11-20 04:25:25,743 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXa8E6i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:25:37 INFO - 2015-11-20 04:25:37,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 141799424 04:25:37 INFO - 2015-11-20 04:25:37,499 DEBUG : BROWSER_OUTPUT: 04:25:58 INFO - 2015-11-20 04:25:58,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42063/tests/v8_7/run.html (next: http://localhost:42063/tests/v8_7/run.html) 04:25:59 INFO - 2015-11-20 04:25:59,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 04:25:59 INFO - 2015-11-20 04:25:59,090 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,091 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:25:59 INFO - 2015-11-20 04:25:59,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:25:59 INFO - 2015-11-20 04:25:59,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:25:59 INFO - 2015-11-20 04:25:59,091 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:25:59 INFO - 2015-11-20 04:25:59,091 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 04:25:59 INFO - 2015-11-20 04:25:59,091 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.19580681392736 04:25:59 INFO - 2015-11-20 04:25:59,092 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 04:25:59 INFO - 2015-11-20 04:25:59,092 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 04:25:59 INFO - 2015-11-20 04:25:59,092 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1066.0980810234541 04:25:59 INFO - 2015-11-20 04:25:59,092 DEBUG : BROWSER_OUTPUT: |5;Earley;711.2375533428165 04:25:59 INFO - 2015-11-20 04:25:59,092 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 04:25:59 INFO - 2015-11-20 04:25:59,092 DEBUG : BROWSER_OUTPUT: |7;RegExp;25000 04:25:59 INFO - 2015-11-20 04:25:59,093 DEBUG : BROWSER_OUTPUT: |8;Splay;641.8485237483953 04:25:59 INFO - 2015-11-20 04:25:59,093 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 04:25:59 INFO - 2015-11-20 04:25:59,093 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:25:59 INFO - 2015-11-20 04:25:59,093 DEBUG : BROWSER_OUTPUT: __startTimestamp1448022359089__endTimestamp 04:25:59 INFO - 2015-11-20 04:25:59,094 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,094 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:25:59 INFO - 2015-11-20 04:25:59,094 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:25:59 INFO - 2015-11-20 04:25:59,094 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,094 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,094 DEBUG : BROWSER_OUTPUT: Values: 165.7 04:25:59 INFO - 2015-11-20 04:25:59,095 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,095 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.20 Median:187.20 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,095 DEBUG : BROWSER_OUTPUT: Values: 187.2 04:25:59 INFO - 2015-11-20 04:25:59,095 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,095 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,096 DEBUG : BROWSER_OUTPUT: Values: 281.0 04:25:59 INFO - 2015-11-20 04:25:59,096 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,096 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,096 DEBUG : BROWSER_OUTPUT: Values: 5050.5 04:25:59 INFO - 2015-11-20 04:25:59,097 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,097 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,097 DEBUG : BROWSER_OUTPUT: Values: 1066.1 04:25:59 INFO - 2015-11-20 04:25:59,097 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,097 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:711.24 Median:711.24 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: Values: 711.2 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: Values: 12096.4 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25000.00 Median:25000.00 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,098 DEBUG : BROWSER_OUTPUT: Values: 25000.0 04:25:59 INFO - 2015-11-20 04:25:59,099 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,099 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:641.85 Median:641.85 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,099 DEBUG : BROWSER_OUTPUT: Values: 641.8 04:25:59 INFO - 2015-11-20 04:25:59,099 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,100 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:25:59 INFO - 2015-11-20 04:25:59,100 DEBUG : BROWSER_OUTPUT: Values: 4845.4 04:25:59 INFO - 2015-11-20 04:25:59,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:25:59 INFO - 2015-11-20 04:25:59,100 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-11-20 04:25:59,970 INFO : Browser exited with error code: 0 04:25:59 INFO - 2015-11-20 04:25:59,984 INFO : Completed test v8_7 (00:00:39) 04:26:00 INFO - 2015-11-20 04:26:00,153 INFO : Completed test suite (00:20:11) 04:26:00 INFO - 2015-11-20 04:26:00,153 DEBUG : Working with test: dromaeo_css 04:26:00 INFO - 2015-11-20 04:26:00,153 DEBUG : Generating results file: dromaeo_css 04:26:00 INFO - 2015-11-20 04:26:00,154 DEBUG : Working with test: kraken 04:26:00 INFO - 2015-11-20 04:26:00,154 DEBUG : Generating results file: kraken 04:26:00 INFO - 2015-11-20 04:26:00,154 INFO : javascript benchmark 04:26:00 INFO - 2015-11-20 04:26:00,155 DEBUG : Working with test: v8_7 04:26:00 INFO - 2015-11-20 04:26:00,155 DEBUG : Generating results file: v8_7 04:26:00 INFO - 2015-11-20 04:26:00,155 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:00 INFO - 2015-11-20 04:26:00,320 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 04:26:00 INFO - 2015-11-20 04:26:00,320 DEBUG : process_Request line: dromaeo_css 7042.22 graph.html#tests=[[72,64,43]] 04:26:00 INFO - 2015-11-20 04:26:00,320 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:00 INFO - 2015-11-20 04:26:00,357 DEBUG : process_Request line: kraken 1504.50 graph.html#tests=[[232,64,43]] 04:26:00 INFO - 2015-11-20 04:26:00,357 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:00 INFO - 2015-11-20 04:26:00,403 DEBUG : process_Request line: v8_7 21367.43 graph.html#tests=[[230,64,43]] 04:26:00 INFO - 2015-11-20 04:26:00,404 INFO : javascript benchmark 04:26:00 INFO - 2015-11-20 04:26:00,408 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3226.4515032444483, 3267.2811981364107, 3279.065466342093, 3315.4695248760195, 3319.618243901952, 5264.631475796696, 5411.945880541193, 5441.075017247068, 5462.999999999995, 5467.398586155519, 5342.252084708134, 5454.072807622703, 5469.097598896187, 5498.972505137479, 5539.058360078786, 4856.3686720726255, 4886.071646387193, 4887.828925987591, 4927.6797008194535, 4989.3604827899, 4996.375453068366, 5008.474110218429, 5086.491350864921, 5096.51583099605, 5119.513646203604, 4833.130036593412, 4963.851084467472, 4965.801367945278, 4971.955889263259, 5084.415292241384, 4963.826266080706, 4991.051700176991, 4993.051320249141, 5029.723365214912, 5054.317667114966, 4787.8563643090765, 4955.677880937727, 4983.202687569971, 4985.950140498585, 5057.797688092472, 5076.314697515825, 5163.406208286057, 5189.714565698885, 5192.532672059533, 5202.297689811865, 5944.762209511614, 6018.8194354169445, 6021.488173505258, 6028.728707208186, 6033.185519954794, 5749.856253593652, 6031.0, 6068.089786532011, 6070.180525629028, 6071.0, 5482.533984611313, 5568.749406276727, 5661.943380566224, 5691.459311365414, 5702.8289151325525, 6004.819855404257, 6039.365866584033, 6050.818475445743, 6057.18228039209, 6060.787872424444, 5553.944460555424, 5824.388439213822, 5834.183214349994, 5835.679037652885, 5859.2382990211, 5766.077427611562, 5880.558958078162, 5904.940950590525, 5909.734061967221, 5917.171595976567, 5740.339860916049, 5764.193012978187, 5764.827055188351, 5797.043487824461, 5814.825555233349, 5646.6047376684055, 5799.3620701722775, 5807.912881306784, 5810.709464526757, 5862.208601838697, 4431.423914891108, 4452.844150454718, 4453.732776033448, 4487.753173575485, 4535.682502224879, 3988.082740969593, 4017.2367250222364, 4061.472008638858, 4062.8171732272117, 4080.2451546464, 5347.893042139135, 5424.647397919122, 5493.917591236134, 5591.30108736408, 5630.943690563124, 5931.73307201177, 5978.282606087298, 5997.70011499432, 6005.219321488266, 6010.789622363196, 5552.08390615552, 5626.606137570413, 5635.943640563624, 5647.689377084218, 5652.576056795675, 5014.147594908874, 5046.0, 5117.2068329409, 5135.563477104413, 5192.480751924777, 5986.73059712314, 6038.516918646497, 6098.190188918898, 6106.642687876592, 6107.46191531438, 5928.0, 6025.0661147522205, 6025.126356678345, 6041.0, 6056.878862422815, 5929.822105336847, 6037.547183961308, 6162.938370616236, 6197.380261973766, 6217.4715149212825, 5772.0, 5829.358770535153, 5840.503557197686, 5873.853153671193, 5912.793052243151, 5902.468777810018, 5924.851878703067, 5929.466348028698, 5938.435848594377, 5950.880982380415, 5583.609147359808, 5694.174344720075, 5800.883982320414, 5805.10020946754, 5807.8548036299435, 5716.485516303553, 5817.040188368872, 5826.592138550261, 5828.300603927556, 5873.676947767743, 5686.57350698691, 5712.942870571407, 5726.570507211893, 5732.799352022659, 5746.252987111816, 5699.0, 5779.36426993022, 5832.94167058324, 5833.095870140135, 5840.678762667924, 5599.468050535193, 5614.7192640367, 5748.907707535554, 5762.654240745569, 5794.913076303943], "unit": "ms", "name": "dojo.html", "value": 5429.943660922678}, {"lowerIsBetter": false, "replicates": [557.8055691545388, 599.4485073732166, 601.1133577972494, 605.6124080588421, 625.4808508937582, 28462.43075138496, 28877.0, 39362.606373936214, 39763.0, 39784.40323395151, 43028.354574681405, 43421.7828910855, 43661.56338436615, 43663.90840228988, 43757.34363984535, 8590.48457092575, 8736.301095912311, 8748.125187481264, 8758.781030474225, 8760.8685869712, 8539.188777066169, 8678.956605216965, 8687.131286871325, 8694.39139260252, 8698.521581313025, 8601.5699215039, 8669.21977022068, 8675.522846243453, 8677.088905664908, 8677.869831952527, 8612.39713220075, 8636.697715579956, 8667.089955554702, 8670.1763332483, 8676.219140277342, 8537.103604121601, 8623.267022303111, 8649.221570058726, 8649.264812490946, 8672.913270867273, 38688.613113868785, 39318.803405982784, 39348.0, 39386.60613393858, 39411.0, 3191.505316675919, 3268.8038717677014, 3308.669133086696, 3339.9499007514905, 3390.3219356128875, 29091.418171636662, 29482.85258573715, 29697.257568560744, 29707.702922970926, 30465.93369232066, 3760.2291530236234, 3842.9423558646645, 3864.3932991996594, 3909.902252443683, 4015.5984401559904, 262463.0, 264026.0, 264209.9999999981, 264920.0, 265302.0, 57058.42941570531, 57375.426245737006, 57434.13848792271, 57452.0, 57464.71267643635, 53010.20484692733, 53793.46206537963, 59168.40831591715, 65644.0, 66516.66741666358, 15137.091774493345, 15269.0, 15341.539753807403, 15416.61458463525, 15446.768298475532, 11124.0, 11198.832017519744, 11269.943650281695, 11272.098232141409, 11281.548738050386, 18733.81266187348, 18893.244270229312, 18911.62176756457, 18918.716219256723, 18992.52518687044, 7532.209118042636, 7870.173631768696, 7874.7243846466245, 7888.171741967126, 7948.403869709795, 864.883240762489, 868.0321441592579, 965.358036905464, 1028.6554004408606, 1057.1120258982337, 28357.858210708815, 28390.574141387897, 28399.85800071028, 28520.156956837036, 28530.286742831595, 996.6013594562088, 1021.3871676993745, 1046.4453839464943, 1070.7804899995638, 1105.662772854271, 14914.254287285592, 14974.62563435901, 15207.923960380127, 15576.688466230838, 15609.68780624404, 320037.0, 320889.76885809354, 322349.0, 324864.0, 325398.0, 52387.47612523902, 52445.7377713109, 52678.209826852624, 52727.0, 52936.735316323175, 1347.8584748601452, 1370.766969615168, 1376.3393571085935, 1377.6211541825878, 1378.0904602962198, 27791.86104069467, 28401.857990709916, 28909.421811564072, 28971.13086607405, 29073.12780616585, 45489.0, 45938.77030614825, 45980.0, 46143.0, 46271.305930410395, 310097.0, 311887.0, 312264.0, 312977.0, 314428.0, 29944.700552994193, 31620.683793162694, 31700.841495792374, 31845.0, 32222.677773221967, 39044.6095539041, 39267.80366098151, 39823.0, 39972.60027399689, 40187.19625607413, 33016.50475242825, 33342.666573333954, 33773.83113084419, 33983.4902476468, 34181.145471363416, 33735.3252934935, 34804.477932831534, 35593.69220673368, 36396.27207455889, 36723.44914826333, 35026.474602881484, 35171.82414087913, 35735.498515103696, 35881.46177807283, 35916.82041589775, 30975.380492389577, 31598.0, 32891.50662740013, 33391.83304083464, 33543.16142096467, 24810.0, 24906.377340566632, 25232.864521096228, 25237.0, 25477.0], "unit": "ms", "name": "ext.html", "value": 18292.97340170119}, {"lowerIsBetter": false, "replicates": [359.72481051995226, 361.8100497238949, 363.8199091449733, 366.3753300622439, 367.5203858964052, 16375.754363684538, 16770.0, 17339.219735111918, 17597.91201043993, 18119.909400453012, 13223.404946777395, 13236.933815330935, 13604.727905441885, 13690.383932723027, 16191.514254572381, 4829.372181616385, 4945.505449455044, 4950.3069570260195, 4951.059298733229, 4952.727599981999, 4834.661573689843, 4860.198067318888, 4868.294097355882, 4870.853874383774, 4892.584130348924, 5023.799048038074, 5114.105031619451, 5163.380394352683, 5172.40517340505, 5258.395284542288, 5127.158711989243, 5157.071727089123, 5166.793328266865, 5179.611529135311, 5941.881162376728, 5332.706701131437, 5357.758900849432, 5373.925214956985, 5374.4894235048, 5383.515483606455, 12623.368831558386, 12660.55688050923, 13250.337483125804, 13328.733425331438, 13332.866706329974, 1970.5369238229005, 2001.3395579458743, 2074.1703318672503, 2148.785121487854, 2223.7998580127705, 9856.260780441424, 10029.648962286285, 13178.802317965143, 13327.73344533104, 13401.061925665208, 1885.9815699522242, 1893.9337569633533, 1920.7022911448748, 1934.6711059119984, 1957.4029920874127, 60102.0, 62856.0, 63478.36521634771, 63756.68121659362, 63960.04059939151, 9972.750681232883, 10189.286749927582, 10223.642172524074, 10240.695843435316, 10260.897391025994, 13123.146995445266, 13188.20870747739, 13251.13867598603, 13305.334733263491, 13317.0, 7814.726484573012, 8013.959930200312, 8036.276735093753, 8106.027276726712, 8119.59402029908, 7869.606519673994, 7907.406944479187, 8007.199280072063, 8034.558099304594, 8040.437169398086, 4473.977630111829, 4551.180787458289, 4568.5862253230025, 4586.334981427674, 4587.243104887723, 1752.1502071495315, 1839.383806424836, 1846.5660569766094, 1868.4768264885854, 1873.7845147807905, 879.9968036438465, 883.4081165619051, 927.248928368024, 1049.354646892171, 1072.4959269143646, 16521.504354869372, 17062.0, 17226.224819883137, 17416.431273518603, 17482.737758933625, 907.7912080221454, 912.3841407050214, 917.4678686361895, 937.1331518345503, 947.4457442396138, 9582.137607615348, 9908.554115064839, 10017.749556261006, 10053.145482634058, 10132.0, 539028.0, 541606.0, 552070.0, 588802.0, 589225.0, 81726.18273817304, 83422.16577834265, 85105.57447212849, 86651.56674216589, 88636.0, 1112.671761830262, 1141.0757286597882, 1143.1597775634903, 1158.652404278713, 1167.346286079815, 14737.0, 15454.613634659223, 15677.137757423452, 15703.685926281181, 16058.518244452685, 31366.843165784026, 31706.04881853548, 31987.0, 32689.019329420156, 33097.0, 38812.223755525294, 39571.208575828896, 40259.597404026754, 40900.79549602352, 41141.382879256234, 9495.952520237632, 9692.273079518924, 9999.900000999896, 10016.248781341283, 10100.090991810772, 11753.823692644446, 11785.528578857093, 17047.232874520923, 17883.552911177325, 17918.820811791717, 13973.371198295898, 14545.563633091024, 14720.116792992454, 14801.111933284037, 14951.177685227416, 13525.729485410433, 13759.587212383645, 13806.93096534511, 13947.372368243656, 13965.0, 13855.584332470042, 13893.930530347689, 14464.566063018126, 14662.0, 15015.924920375328, 9515.524223788645, 9527.190188834027, 9571.090746379083, 9657.082577155159, 9737.951310243403, 10160.390376577428, 10502.527386267484, 13084.542041028899, 14584.124952502883, 14982.0], "unit": "ms", "name": "jquery.html", "value": 8736.474938051055}, {"lowerIsBetter": false, "replicates": [1452.8329242137154, 1504.3982407037183, 1587.5951632333754, 1622.1402656592004, 1736.696078186318, 7232.566046037242, 7406.185319614845, 7454.366378857803, 7470.813229669254, 7614.73348432805, 7229.602371869558, 7259.854802903938, 7299.416046716263, 7310.926890731091, 7342.706291748337, 2268.8298377621704, 2296.7818057284617, 2303.1823702585593, 2307.3885420363617, 2309.399556115405, 2307.8384513084093, 2335.4278201840575, 2338.4037070546988, 2340.789328960393, 2356.0, 2240.574290884727, 2296.7243930728337, 2305.4697419593504, 2310.1914329984456, 2325.6278995360744, 2205.2832829330373, 2258.0854753824647, 2306.4925716342464, 2308.2382813671447, 2312.7918487336137, 2257.413072601119, 2297.5634629420356, 2297.9655305170436, 2299.7470278269543, 2302.82728795341, 7385.66764495599, 7388.298111679382, 7456.3289303962365, 7461.403087752967, 7472.402207823361, 4643.930341044887, 4714.4106986626675, 4750.809967601326, 4769.713817170981, 4775.522447755231, 3042.7413669838093, 3084.90745277642, 3154.810711357326, 3199.6640352762856, 3207.5188721691698, 1091.6397588795678, 1097.4896673046992, 1113.799516087104, 1125.4260327233087, 1145.8395824584481, 9827.852582211273, 9870.506474676238, 9872.506374681308, 9877.25920555954, 9885.0, 4017.116234428421, 4097.836086556564, 4104.794760261975, 4114.650254728322, 4172.561881002512, 8116.715914942949, 8163.795905102301, 8178.46839955401, 8201.42590018693, 8203.71287004952, 4534.9319760203625, 4540.409746732904, 4544.772761361919, 4555.544445555484, 4569.383133276965, 4175.791210439465, 4184.058586817941, 4186.372044193396, 4213.241616509058, 4227.133437645275, 3374.7300215982664, 3461.9268026911236, 3470.6008808986785, 3477.5826900771563, 3478.721702263813, 1027.9691609251734, 1029.912457441111, 1036.9429681367446, 1037.9740506487246, 1040.8386700061503, 1065.680295911239, 1071.5927947379946, 1110.9611163609236, 1232.4885172653428, 1349.0489205110373, 6695.230048544479, 6712.93287067123, 6751.831204219934, 6779.2881747416795, 6903.6203008835, 1059.4861492176287, 1059.7668512927144, 1061.3631820907394, 1069.9350254009835, 1079.8866119057386, 5309.097453432925, 5337.532178650902, 5344.545713614309, 5355.0, 5356.491133342326, 8573.571321433903, 8754.299656027502, 8812.515311657791, 8863.64545418176, 8935.776605584782, 8738.344624153215, 8748.34387420946, 8776.736697899074, 8787.077356877437, 8812.383133180616, 6635.435987940982, 6669.599824010575, 6824.249332573413, 6830.112085428962, 6878.621675807779, 6774.762883299061, 6794.830129246809, 6834.658267086526, 6880.277570854988, 6892.241853396223, 7739.535627862347, 7830.060392752906, 7833.37333013369, 7896.960515197387, 7973.641186146753, 7863.84272314562, 7912.28789408956, 7923.920760792318, 7925.484843485155, 8112.472689275178, 6306.211723534559, 6626.469882409299, 6632.0, 6666.066750654815, 6684.532082754161, 7046.682899269647, 7054.717811287491, 7129.0, 7139.643017848983, 7144.714211431485, 6517.543771936109, 6525.2822189558165, 6570.047343135314, 6687.331266873273, 6729.663516824237, 6414.679266036773, 6639.900401493885, 6656.068150459037, 6694.698738556874, 6745.696443660146, 6622.304658011032, 6695.765648202289, 6793.150856142982, 6795.218549866829, 6846.5892046477375, 6217.440430361289, 6223.937760622517, 6226.0, 6245.313015568375, 6258.593191442542, 6322.620642761449, 6331.176946996861, 6334.714937827716, 6382.585131966407, 6453.709583068867], "unit": "ms", "name": "mootools.html", "value": 4333.093953789449}, {"lowerIsBetter": false, "replicates": [344.39042894077465, 345.0779160078364, 346.49065873166444, 346.8751249550163, 351.6465951718524, 6272.466840318572, 6319.146915166451, 6336.7465301388, 6364.904526432101, 6427.2929977702415, 6259.217597800275, 6297.307296197415, 6339.714712837922, 6352.301246862841, 6355.269144048436, 4795.96886669366, 4820.542048505386, 4822.469528351896, 4825.372701548794, 4829.203181475053, 4800.983586893513, 4801.063792560452, 4810.446798618152, 4822.373091498118, 4834.274858771178, 4651.744154071542, 4743.359646447737, 4747.1692453820615, 4748.7863046163, 4776.785044672998, 4748.0978614063215, 4759.333693282926, 4771.8091276348905, 4776.116418462579, 4781.617470602343, 4135.400366946806, 4136.131412403399, 4136.420901073852, 4142.606452387018, 4144.046869220066, 6008.068749343859, 6074.96962515189, 6078.240219972504, 6080.361562036011, 6085.2697676278685, 5428.83713488596, 5562.582806289544, 5579.776808927638, 5583.274174357348, 5601.439856014406, 6726.293739157416, 6739.0, 6749.898751518731, 6769.05233267343, 6791.2869148739655, 4593.219152744042, 4594.1271158479785, 4597.60920321773, 4598.885027874297, 4605.102005109005, 6774.796756097325, 6931.341522555349, 6979.965100174467, 7002.439804815603, 7048.400885924702, 4641.303804429295, 4705.882352941204, 4721.4570324413135, 4726.810927562928, 4735.579326202125, 4782.593479554277, 4788.545088216614, 4790.4969978152485, 4795.304680821261, 4797.376341075638, 5548.722563871871, 5555.194496797942, 5567.109262517978, 5580.944190558123, 5581.6371935824045, 6605.966970165118, 6760.628165450948, 6780.966095169591, 6796.558223715443, 6804.591724496546, 1620.651559914624, 1658.3781082094215, 1670.8329167083436, 1690.7125788615965, 1691.6785810695928, 1090.9181811364178, 1121.7083558274744, 1127.8872112788656, 1128.0637071230858, 1134.880837512066, 6332.176817013758, 6346.809595712136, 6369.745210191633, 6404.039394090831, 6478.190226221723, 6918.411934985583, 6924.930750692429, 6951.548149370275, 6956.130483689539, 6956.495661561834, 6377.17096777416, 6408.231012278463, 6451.387118223761, 6455.096286519891, 6462.806115816533, 3793.905152371213, 3833.1950290438763, 3833.616638336144, 3835.079580900564, 3838.539375274929, 7275.345218930322, 7286.271372862671, 7290.927090729131, 7303.379212766974, 7334.156571994182, 7061.752838650623, 7215.665101956155, 7254.310840470147, 7257.673404696696, 7259.274072592804, 7294.854102917806, 7298.817529561803, 7313.89029164563, 7317.158526769384, 7326.706931722778, 6980.860382792417, 7012.929870701431, 7048.0, 7054.0, 7064.682089305891, 6723.26044135135, 6950.478714096362, 6954.061201737701, 6965.79102626922, 6987.196472405739, 7276.4178865689555, 7279.1265048194555, 7313.378362839218, 7326.487145899736, 7334.156571994289, 4703.341532185428, 4743.715377077387, 4759.048190361872, 4761.214399624162, 4767.928481072856, 6805.0, 6850.828729281808, 6957.686904089429, 7048.048513450619, 7063.646817658993, 6830.931690683228, 6851.725930962705, 6865.313468653095, 6867.107276054081, 6867.175938887365, 6833.760818371333, 6836.316368363124, 6836.42762164695, 6838.521303508706, 6848.794536163923, 6514.902276465762, 6654.268030516542, 6719.193696756421, 6732.899006514808, 6733.696983635846, 6890.552114112566, 6891.655417229219, 6900.6204658744255, 6903.102596662402, 6907.93092069093, 6625.734970601122, 6706.195256569243, 6711.228208756055, 6718.496112791658, 6722.19333679942], "unit": "ms", "name": "prototype.html", "value": 5073.9234230162765}, {"lowerIsBetter": false, "replicates": [825.8761185822126, 832.6169961817563, 845.5180547088158, 846.0946786937975, 847.4957400346799, 12871.09902306839, 13138.277394743285, 13205.207687538754, 13226.40481178348, 13355.998300127492, 13042.73914521709, 13153.934230328836, 13256.403461844217, 13262.867371326283, 13306.800397994013, 816.9999999999985, 834.1450013735939, 835.031363618203, 835.302522393802, 835.4694768821812, 827.0488937721608, 834.8330333933208, 837.7863644770575, 843.0431460292551, 843.0515669871395, 857.3012994409536, 865.4807115730574, 866.8829707989404, 868.8436081505326, 869.443556124081, 857.5540718826206, 860.6987554355987, 863.7279257034014, 864.1013346120028, 865.6191275838611, 632.8892443822313, 634.4955760170675, 635.6345101566618, 636.5098873867142, 637.073058699591, 14109.506167284198, 14173.645658858508, 14194.290285485788, 14209.50266740659, 14251.57245282643, 11870.287782732978, 12056.397180140957, 12101.69745756363, 12123.117144895623, 12480.687982800502, 9685.661001864972, 9895.604175832957, 9998.70003899877, 10181.28730988831, 10599.894001059967, 3511.280187561569, 3621.8551257949653, 3621.9275614487565, 3643.0710168907026, 3705.221903400289, 46646.53353466456, 47055.529444705455, 47077.529224708, 47168.52831471676, 47294.0, 9813.27409934261, 9879.407235565888, 9954.402735835729, 10101.646442374482, 10135.239857010607, 17821.0, 17834.91082544579, 17838.732419013726, 17846.286148554173, 17871.821281787015, 7397.741079062207, 7435.814104647319, 7450.813729656802, 7493.3630641395, 7558.281963213486, 4199.454070970815, 4217.1776503581505, 4232.640225580799, 4263.381809637585, 4364.9960509083085, 3078.569000339954, 3087.830169340663, 3088.722015018614, 3089.9845500772353, 3098.752099832008, 550.4468009650276, 568.1874918866062, 571.794154104522, 573.0372973404637, 573.9339975902741, 652.6149571752688, 655.6885479397248, 665.9400653941168, 691.5193940211504, 718.5437247347971, 8039.261509698509, 8468.872966905501, 8511.95744021276, 8653.134686531297, 8722.781930451789, 648.4164252173082, 650.391883588846, 661.1702313596405, 673.7406098651957, 733.5561984999106, 3910.2570511602703, 4042.9797851010558, 4244.8514301999285, 4268.466441694788, 4439.66702497314, 57058.00296989585, 57461.712691436274, 57469.71265143731, 57630.13554796681, 57654.13518797221, 50964.74517627462, 52133.218001730005, 52447.0, 52488.47511524836, 52640.0, 44573.55426445759, 44781.55218447839, 45901.0, 46426.767866159775, 47610.0, 8557.44376615518, 8825.735227943173, 9364.297677674065, 9482.908942352233, 9493.145616894513, 35282.1179470505, 35995.28009439849, 36326.27347453089, 37149.44275835919, 37832.0, 41617.0, 45047.0, 45551.0, 45817.77091114523, 45841.77079114583, 11028.28316159447, 11106.0, 11293.604723834625, 11421.885781142082, 11440.0, 12172.57395991136, 12225.266484010988, 12419.19275247106, 12866.356682165668, 12937.935310323388, 11390.829137562778, 11637.127215458706, 11713.0, 11720.531178752753, 11763.117766167743, 11083.72290692739, 11167.553297867995, 11275.379854108103, 11450.0, 11732.237404568676, 11147.275427097213, 11203.383813890314, 11562.248453850472, 11612.129090318429, 11651.533938642699, 9957.0, 10150.390976541432, 10256.768628703849, 10296.794064118825, 10464.058234758604, 9375.531223438937, 9850.556724947251, 9860.0, 9874.605015799287, 10119.544620491948], "unit": "ms", "name": "yui.html", "value": 6392.419903764614}], "name": "dromaeo_css", "value": 7042.227576756099}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 110.0, 110.0, 123.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 149.0, 171.0, 126.0, 154.0, 149.0, 124.0, 162.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 164.0, 162.0, 163.0, 162.0, 164.0, 168.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 74.0, 72.0, 72.0, 136.0, 72.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 131.0, 91.0, 91.0, 91.0, 140.0, 91.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 97.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 87.0, 84.0, 84.0, 84.0, 84.0, 87.0, 93.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 131.0, 118.0, 119.0, 114.0, 122.0, 121.0, 127.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [140.0, 148.0, 147.0, 147.0, 160.0, 143.0, 152.0, 148.0, 149.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 68.0, 67.0, 67.0, 70.0, 68.0, 68.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1504.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "Richards", "value": 213.01226799999995}, {"lowerIsBetter": false, "replicates": [187.19580681392736], "unit": "score", "name": "DeltaBlue", "value": 353.20235600000007}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [711.2375533428165], "unit": "score", "name": "Earley", "value": 937.0469780000002}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25000.0], "unit": "score", "name": "RegExp", "value": 36.43939999999999}, {"lowerIsBetter": false, "replicates": [641.8485237483953], "unit": "score", "name": "Splay", "value": 126.962978}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21367.43259703359}]} 04:26:00 INFO - RETURN: dromaeo_css: 7042.22 04:26:00 INFO - RETURN: kraken: 1504.50 04:26:00 INFO - RETURN: v8_7: 21367.43 04:26:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21367.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1504.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7042.22"}}} 04:26:00 INFO - Return code: 0 04:26:00 INFO - # TBPL SUCCESS # 04:26:00 INFO - Running post-action listener: _resource_record_post_action 04:26:00 INFO - Running post-run listener: _resource_record_post_run 04:26:01 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 509411328; Read time: 0; Write time: 526104 04:26:01 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 221433856; Read time: 0; Write time: 322628 04:26:01 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 287715328; Read time: 0; Write time: 203436 04:26:01 INFO - Running post-run listener: _upload_blobber_files 04:26:01 INFO - Blob upload gear active. 04:26:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:26:01 INFO - Copying logs to upload dir... 04:26:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.203635 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-20 04:26:01.245244) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:01.249190) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010138 build_url: 'https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/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-20 04:26:01.299474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:01.299805) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448021023.792086-1972566198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:01.349361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:26:01.349651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:26:01.349932) ========= ========= Total master_lag: 0.21 =========