builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1447896071.41 results: success (0) buildid: 20151118154238 builduid: 20dbdfe610c0437781d87bc7060f24b8 revision: e8c43ec095e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.414332) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.414773) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.415062) ========= 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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006542 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.435285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.435560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.448171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.448450) ========= 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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.497424) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.497708) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.498059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.498346) ========= 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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 17:21:12-- 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% 225M=0s 2015-11-18 17:21:12 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.635651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.635989) ========= 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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018514 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:11.685640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 17:21:11.686005) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e8c43ec095e3 --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 e8c43ec095e3 --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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 17:21:12,304 Setting DEBUG logging. 2015-11-18 17:21:12,304 attempt 1/10 2015-11-18 17:21:12,305 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e8c43ec095e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 17:21:13,544 unpacking tar archive at: fx-team-e8c43ec095e3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.577073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 17:21:13.275964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:13.276322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:13.289982) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:13.290239) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 17:21:13.290630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-18 17:21:13.290941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:21:13 INFO - MultiFileLogger online at 20151118 17:21:13 in /builds/slave/test-pgo 17:21:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 17:21:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:21:13 INFO - {'append_to_log': False, 17:21:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:21:13 INFO - 'blob_upload_branch': 'Fx-Team', 17:21:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:21:13 INFO - 'branch': 'Fx-Team', 17:21:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:21:13 INFO - 'config_files': ('talos/linux_config.py',), 17:21:13 INFO - 'default_actions': ('clobber', 17:21:13 INFO - 'read-buildbot-config', 17:21:13 INFO - 'download-and-extract', 17:21:13 INFO - 'populate-webroot', 17:21:13 INFO - 'create-virtualenv', 17:21:13 INFO - 'install', 17:21:13 INFO - 'run-tests'), 17:21:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:21:13 INFO - 'download_minidump_stackwalk': True, 17:21:13 INFO - 'download_symbols': 'ondemand', 17:21:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:21:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:21:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:21:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:21:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:21:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:21:13 INFO - 'installer_path': 'installer.exe', 17:21:13 INFO - 'log_level': 'info', 17:21:13 INFO - 'log_name': 'talos', 17:21:13 INFO - 'log_to_console': True, 17:21:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:21:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:21:13 INFO - 'opt_config_files': (), 17:21:13 INFO - 'pip_index': False, 17:21:13 INFO - 'sps_profile': False, 17:21:13 INFO - 'sps_profile_interval': 0, 17:21:13 INFO - 'suite': 'dromaeojs', 17:21:13 INFO - 'system_bits': '64', 17:21:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:21:13 INFO - 'title': 'talos-linux64-ix-061', 17:21:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:21:13 INFO - 'use_talos_json': True, 17:21:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:21:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:21:13 INFO - 'work_dir': 'build'} 17:21:13 INFO - ##### 17:21:13 INFO - ##### Running clobber step. 17:21:13 INFO - ##### 17:21:13 INFO - Running pre-action listener: _resource_record_pre_action 17:21:13 INFO - Running main action method: clobber 17:21:13 INFO - rmtree: /builds/slave/test-pgo/build 17:21:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:21:14 INFO - Running post-action listener: _resource_record_post_action 17:21:14 INFO - ##### 17:21:14 INFO - ##### Running read-buildbot-config step. 17:21:14 INFO - ##### 17:21:14 INFO - Running pre-action listener: _resource_record_pre_action 17:21:14 INFO - Running main action method: read_buildbot_config 17:21:14 INFO - Using buildbot properties: 17:21:14 INFO - { 17:21:14 INFO - "properties": { 17:21:14 INFO - "buildnumber": 498, 17:21:14 INFO - "product": "firefox", 17:21:14 INFO - "script_repo_revision": "production", 17:21:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:21:14 INFO - "repository": "", 17:21:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:21:14 INFO - "buildid": "20151118154238", 17:21:14 INFO - "slavename": "talos-linux64-ix-061", 17:21:14 INFO - "pgo_build": "True", 17:21:14 INFO - "basedir": "/builds/slave/test-pgo", 17:21:14 INFO - "project": "", 17:21:14 INFO - "platform": "ubuntu64_hw", 17:21:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:21:14 INFO - "slavebuilddir": "test", 17:21:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:21:14 INFO - "branch": "fx-team", 17:21:14 INFO - "repo_path": "integration/fx-team", 17:21:14 INFO - "stage_platform": "linux64-pgo", 17:21:14 INFO - "builduid": "20dbdfe610c0437781d87bc7060f24b8", 17:21:14 INFO - "revision": "e8c43ec095e3" 17:21:14 INFO - }, 17:21:14 INFO - "sourcestamp": { 17:21:14 INFO - "repository": "", 17:21:14 INFO - "hasPatch": false, 17:21:14 INFO - "project": "", 17:21:14 INFO - "branch": "fx-team-linux64-pgo-talos", 17:21:14 INFO - "changes": [ 17:21:14 INFO - { 17:21:14 INFO - "category": null, 17:21:14 INFO - "files": [ 17:21:14 INFO - { 17:21:14 INFO - "url": null, 17:21:14 INFO - "name": "https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:21:14 INFO - } 17:21:14 INFO - ], 17:21:14 INFO - "repository": "", 17:21:14 INFO - "rev": "e8c43ec095e3", 17:21:14 INFO - "who": "mozci-bot@mozilla.com", 17:21:14 INFO - "when": 1447895502, 17:21:14 INFO - "number": 6680190, 17:21:14 INFO - "comments": "", 17:21:14 INFO - "project": "", 17:21:14 INFO - "at": "Wed 18 Nov 2015 17:11:42", 17:21:14 INFO - "branch": "fx-team-linux64-pgo-talos", 17:21:14 INFO - "revlink": "", 17:21:14 INFO - "properties": [ 17:21:14 INFO - [ 17:21:14 INFO - "buildid", 17:21:14 INFO - "20151118154238", 17:21:14 INFO - "Change" 17:21:14 INFO - ], 17:21:14 INFO - [ 17:21:14 INFO - "builduid", 17:21:14 INFO - "20dbdfe610c0437781d87bc7060f24b8", 17:21:14 INFO - "Change" 17:21:14 INFO - ], 17:21:14 INFO - [ 17:21:14 INFO - "pgo_build", 17:21:14 INFO - "True", 17:21:14 INFO - "Change" 17:21:14 INFO - ] 17:21:14 INFO - ], 17:21:14 INFO - "revision": "e8c43ec095e3" 17:21:14 INFO - } 17:21:14 INFO - ], 17:21:14 INFO - "revision": "e8c43ec095e3" 17:21:14 INFO - } 17:21:14 INFO - } 17:21:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:21:14 INFO - Running post-action listener: _resource_record_post_action 17:21:14 INFO - ##### 17:21:14 INFO - ##### Running download-and-extract step. 17:21:14 INFO - ##### 17:21:14 INFO - Running pre-action listener: _resource_record_pre_action 17:21:14 INFO - Running main action method: download_and_extract 17:21:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:21:14 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')]} 17:21:14 INFO - https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/test_packages.json 17:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/test_packages.json 17:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:21:15 INFO - Downloaded 1302 bytes. 17:21:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:21:15 INFO - Using the following test package requirements: 17:21:15 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:21:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'jsshell-linux-x86_64.zip'], 17:21:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:21:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:21:15 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:21:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:21:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:21:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:15 INFO - https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:16 INFO - Downloaded 22475150 bytes. 17:21:16 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 17:21:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:21:16 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 17:21:17 INFO - Return code: 0 17:21:17 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 17:21:17 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')]} 17:21:17 INFO - https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:19 INFO - Downloaded 22475150 bytes. 17:21:19 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 17:21:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:21:19 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 17:21:20 INFO - Return code: 0 17:21:20 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')]} 17:21:20 INFO - https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:21 INFO - Downloaded 11130997 bytes. 17:21:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:21:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:21:21 INFO - Return code: 0 17:21: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')]} 17:21:21 INFO - https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:21:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:21:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:21:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1PqMKa6S1ixNRsblALapw/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 17:21:22 INFO - Downloaded 57205363 bytes. 17:21:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:21:22 INFO - mkdir: /builds/slave/test-pgo/properties 17:21:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:21:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:21:22 INFO - Contents: 17:21:22 INFO - build_url:https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:21:22 INFO - Running post-action listener: _resource_record_post_action 17:21:22 INFO - Running post-action listener: set_extra_try_arguments 17:21:22 INFO - ##### 17:21:22 INFO - ##### Running populate-webroot step. 17:21:22 INFO - ##### 17:21:22 INFO - Running pre-action listener: _resource_record_pre_action 17:21:22 INFO - Running main action method: populate_webroot 17:21:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:21:22 INFO - '../fennec_ids.txt'], 17:21:22 INFO - 'tests': ['tcheck2']}, 17:21:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:22 INFO - '--tppagecycles', 17:21:22 INFO - '7'], 17:21:22 INFO - 'tests': ['tsvgm']}}, 17:21:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:21:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:21:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:21:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'tests': ['damp', 'tps']}, 17:21:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['damp', 'tps']}, 17:21:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:21:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:22 INFO - 'other': {'tests': ['a11yr', 17:21:22 INFO - 'ts_paint', 17:21:22 INFO - 'tpaint', 17:21:22 INFO - 'sessionrestore', 17:21:22 INFO - 'sessionrestore_no_auto_restore']}, 17:21:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['a11yr', 17:21:22 INFO - 'ts_paint', 17:21:22 INFO - 'tpaint', 17:21:22 INFO - 'sessionrestore', 17:21:22 INFO - 'sessionrestore_no_auto_restore']}, 17:21:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['a11yr', 17:21:22 INFO - 'ts_paint', 17:21:22 INFO - 'tpaint', 17:21:22 INFO - 'sessionrestore', 17:21:22 INFO - 'sessionrestore_no_auto_restore']}, 17:21:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['a11yr', 17:21:22 INFO - 'ts_paint', 17:21:22 INFO - 'tpaint', 17:21:22 INFO - 'sessionrestore', 17:21:22 INFO - 'sessionrestore_no_auto_restore']}, 17:21:22 INFO - 'other_l64': {'tests': ['a11yr', 17:21:22 INFO - 'ts_paint', 17:21:22 INFO - 'tpaint', 17:21:22 INFO - 'sessionrestore', 17:21:22 INFO - 'sessionrestore_no_auto_restore']}, 17:21:22 INFO - 'other_nol64': {'tests': ['a11yr', 17:21:22 INFO - 'ts_paint', 17:21:22 INFO - 'tpaint', 17:21:22 INFO - 'sessionrestore', 17:21:22 INFO - 'sessionrestore_no_auto_restore']}, 17:21:22 INFO - 'svgr': {'tests': ['tsvgx', 17:21:22 INFO - 'tsvgr_opacity', 17:21:22 INFO - 'tart', 17:21:22 INFO - 'tscrollx', 17:21:22 INFO - 'cart']}, 17:21:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['tsvgx', 17:21:22 INFO - 'tsvgr_opacity', 17:21:22 INFO - 'tart', 17:21:22 INFO - 'tscrollx', 17:21:22 INFO - 'cart']}, 17:21:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'tests': ['tp5o']}, 17:21:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'talos_options': ['--e10s'], 17:21:22 INFO - 'tests': ['tp5o']}, 17:21:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'talos_options': ['--xperf_path', 17:21:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:22 INFO - 'tests': ['tp5n']}, 17:21:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:22 INFO - 'talos_options': ['--e10s', 17:21:22 INFO - '--xperf_path', 17:21:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:22 INFO - 'tests': ['tp5n']}}, 17:21:22 INFO - 'talos.zip': {'path': '', 17:21:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:22 INFO - Running post-action listener: _resource_record_post_action 17:21:22 INFO - ##### 17:21:22 INFO - ##### Running create-virtualenv step. 17:21:22 INFO - ##### 17:21:22 INFO - Running pre-action listener: _resource_record_pre_action 17:21:22 INFO - Running main action method: create_virtualenv 17:21:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:21:22 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 17:21:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:21:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:23 INFO - Using real prefix '/usr' 17:21:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:21:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:25 INFO - Installing pip.................done. 17:21:25 INFO - Return code: 0 17:21:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:21:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:21:25 INFO - Using env: {'DISPLAY': ':0', 17:21:25 INFO - 'HOME': '/home/cltbld', 17:21:25 INFO - 'LANG': 'en_US.UTF-8', 17:21:25 INFO - 'LANGUAGE': 'en_US:en', 17:21:25 INFO - 'LOGNAME': 'cltbld', 17:21:25 INFO - 'MAIL': '/var/mail/cltbld', 17:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:25 INFO - 'MOZ_NO_REMOTE': '1', 17:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:25 INFO - 'NO_EM_RESTART': '1', 17:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:25 INFO - 'SHELL': '/bin/bash', 17:21:25 INFO - 'SHLVL': '1', 17:21:25 INFO - 'TERM': 'linux', 17:21:25 INFO - 'TMOUT': '86400', 17:21:25 INFO - 'USER': 'cltbld', 17:21:25 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:25 INFO - '_': '/tools/buildbot/bin/python'} 17:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:21:25 INFO - Cleaning up... 17:21:25 INFO - Return code: 0 17:21:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:21:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:21:25 INFO - Using env: {'DISPLAY': ':0', 17:21:25 INFO - 'HOME': '/home/cltbld', 17:21:25 INFO - 'LANG': 'en_US.UTF-8', 17:21:25 INFO - 'LANGUAGE': 'en_US:en', 17:21:25 INFO - 'LOGNAME': 'cltbld', 17:21:25 INFO - 'MAIL': '/var/mail/cltbld', 17:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:25 INFO - 'MOZ_NO_REMOTE': '1', 17:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:25 INFO - 'NO_EM_RESTART': '1', 17:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:25 INFO - 'SHELL': '/bin/bash', 17:21:25 INFO - 'SHLVL': '1', 17:21:25 INFO - 'TERM': 'linux', 17:21:25 INFO - 'TMOUT': '86400', 17:21:25 INFO - 'USER': 'cltbld', 17:21:25 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:25 INFO - '_': '/tools/buildbot/bin/python'} 17:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:26 INFO - Downloading/unpacking psutil>=0.7.1 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:27 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:21:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:21:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:27 INFO - Installing collected packages: psutil 17:21:27 INFO - Running setup.py install for psutil 17:21:27 INFO - building 'psutil._psutil_linux' extension 17:21:27 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 17:21:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:21:28 INFO - building 'psutil._psutil_posix' extension 17:21:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:21:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:28 INFO - Successfully installed psutil 17:21:28 INFO - Cleaning up... 17:21:28 INFO - Return code: 0 17:21:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:21:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:21:28 INFO - Using env: {'DISPLAY': ':0', 17:21:28 INFO - 'HOME': '/home/cltbld', 17:21:28 INFO - 'LANG': 'en_US.UTF-8', 17:21:28 INFO - 'LANGUAGE': 'en_US:en', 17:21:28 INFO - 'LOGNAME': 'cltbld', 17:21:28 INFO - 'MAIL': '/var/mail/cltbld', 17:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:28 INFO - 'MOZ_NO_REMOTE': '1', 17:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:28 INFO - 'NO_EM_RESTART': '1', 17:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:28 INFO - 'SHELL': '/bin/bash', 17:21:28 INFO - 'SHLVL': '1', 17:21:28 INFO - 'TERM': 'linux', 17:21:28 INFO - 'TMOUT': '86400', 17:21:28 INFO - 'USER': 'cltbld', 17:21:28 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:28 INFO - '_': '/tools/buildbot/bin/python'} 17:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:21:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:21:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:21:30 INFO - Installing collected packages: mozsystemmonitor 17:21:30 INFO - Running setup.py install for mozsystemmonitor 17:21:30 INFO - Successfully installed mozsystemmonitor 17:21:30 INFO - Cleaning up... 17:21:30 INFO - Return code: 0 17:21:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:21: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')]} 17:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:21:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:21:30 INFO - Using env: {'DISPLAY': ':0', 17:21:30 INFO - 'HOME': '/home/cltbld', 17:21:30 INFO - 'LANG': 'en_US.UTF-8', 17:21:30 INFO - 'LANGUAGE': 'en_US:en', 17:21:30 INFO - 'LOGNAME': 'cltbld', 17:21:30 INFO - 'MAIL': '/var/mail/cltbld', 17:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:30 INFO - 'MOZ_NO_REMOTE': '1', 17:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:30 INFO - 'NO_EM_RESTART': '1', 17:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:30 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:30 INFO - 'SHELL': '/bin/bash', 17:21:30 INFO - 'SHLVL': '1', 17:21:30 INFO - 'TERM': 'linux', 17:21:30 INFO - 'TMOUT': '86400', 17:21:30 INFO - 'USER': 'cltbld', 17:21:30 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:30 INFO - '_': '/tools/buildbot/bin/python'} 17:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:30 INFO - Downloading/unpacking blobuploader==1.2.4 17:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:32 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:21:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:21:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:32 INFO - Downloading docopt-0.6.1.tar.gz 17:21:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:21:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:32 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:32 INFO - Running setup.py install for blobuploader 17:21:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:21:33 INFO - Running setup.py install for requests 17:21:33 INFO - Running setup.py install for docopt 17:21:33 INFO - Successfully installed blobuploader requests docopt 17:21:33 INFO - Cleaning up... 17:21:33 INFO - Return code: 0 17:21:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:21: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')]} 17:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:21:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:21:33 INFO - Using env: {'DISPLAY': ':0', 17:21:33 INFO - 'HOME': '/home/cltbld', 17:21:33 INFO - 'LANG': 'en_US.UTF-8', 17:21:33 INFO - 'LANGUAGE': 'en_US:en', 17:21:33 INFO - 'LOGNAME': 'cltbld', 17:21:33 INFO - 'MAIL': '/var/mail/cltbld', 17:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:33 INFO - 'MOZ_NO_REMOTE': '1', 17:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:33 INFO - 'NO_EM_RESTART': '1', 17:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:33 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:33 INFO - 'SHELL': '/bin/bash', 17:21:33 INFO - 'SHLVL': '1', 17:21:33 INFO - 'TERM': 'linux', 17:21:33 INFO - 'TMOUT': '86400', 17:21:33 INFO - 'USER': 'cltbld', 17:21:33 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:33 INFO - '_': '/tools/buildbot/bin/python'} 17:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:33 INFO - Running setup.py (path:/tmp/pip-YVjq_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:33 INFO - Running setup.py (path:/tmp/pip-jRLSj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:33 INFO - Running setup.py (path:/tmp/pip-Kyvfq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:34 INFO - Running setup.py (path:/tmp/pip-YSnxrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:34 INFO - Running setup.py (path:/tmp/pip-5HRhqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:34 INFO - Running setup.py (path:/tmp/pip-Oy4_Is-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:34 INFO - Running setup.py (path:/tmp/pip-xRCpv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:34 INFO - Running setup.py (path:/tmp/pip-FcQ_o_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:34 INFO - Running setup.py (path:/tmp/pip-CvgThz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:34 INFO - Running setup.py (path:/tmp/pip-_Rta9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:34 INFO - Running setup.py (path:/tmp/pip-ucfBfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:34 INFO - Running setup.py (path:/tmp/pip-H5slAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:34 INFO - Running setup.py (path:/tmp/pip-GMscjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:34 INFO - Running setup.py (path:/tmp/pip-46gCew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:34 INFO - Running setup.py (path:/tmp/pip-zqiHOk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:34 INFO - Running setup.py (path:/tmp/pip-8knG8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:34 INFO - Running setup.py (path:/tmp/pip-2rwiqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:35 INFO - Running setup.py install for manifestparser 17:21:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Running setup.py install for mozcrash 17:21:35 INFO - Running setup.py install for mozdebug 17:21:35 INFO - Running setup.py install for mozdevice 17:21:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Running setup.py install for mozfile 17:21:35 INFO - Running setup.py install for mozhttpd 17:21:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Running setup.py install for mozinfo 17:21:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Running setup.py install for mozInstall 17:21:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:21:35 INFO - Running setup.py install for mozleak 17:21:35 INFO - Running setup.py install for mozlog 17:21:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Running setup.py install for moznetwork 17:21:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Running setup.py install for mozprocess 17:21:36 INFO - Running setup.py install for mozprofile 17:21:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Running setup.py install for mozrunner 17:21:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Running setup.py install for mozscreenshot 17:21:36 INFO - Running setup.py install for moztest 17:21:36 INFO - Running setup.py install for mozversion 17:21:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:21:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:21:36 INFO - Cleaning up... 17:21:36 INFO - Return code: 0 17:21:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:21:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:21:36 INFO - Using env: {'DISPLAY': ':0', 17:21:36 INFO - 'HOME': '/home/cltbld', 17:21:36 INFO - 'LANG': 'en_US.UTF-8', 17:21:36 INFO - 'LANGUAGE': 'en_US:en', 17:21:36 INFO - 'LOGNAME': 'cltbld', 17:21:36 INFO - 'MAIL': '/var/mail/cltbld', 17:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:36 INFO - 'MOZ_NO_REMOTE': '1', 17:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:36 INFO - 'NO_EM_RESTART': '1', 17:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:36 INFO - 'SHELL': '/bin/bash', 17:21:36 INFO - 'SHLVL': '1', 17:21:36 INFO - 'TERM': 'linux', 17:21:36 INFO - 'TMOUT': '86400', 17:21:36 INFO - 'USER': 'cltbld', 17:21:36 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:36 INFO - '_': '/tools/buildbot/bin/python'} 17:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:37 INFO - Running setup.py (path:/tmp/pip-qyRsrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:37 INFO - Running setup.py (path:/tmp/pip-jlmuDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:37 INFO - Running setup.py (path:/tmp/pip-M2CZju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:37 INFO - Running setup.py (path:/tmp/pip-KfgCgH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:37 INFO - Running setup.py (path:/tmp/pip-uj7raj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:37 INFO - Running setup.py (path:/tmp/pip-cj2cZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:37 INFO - Running setup.py (path:/tmp/pip-hPrejq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:37 INFO - Running setup.py (path:/tmp/pip-ThF5AK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:37 INFO - Running setup.py (path:/tmp/pip-Ulseo0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:37 INFO - Running setup.py (path:/tmp/pip-hBTFSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:37 INFO - Running setup.py (path:/tmp/pip-dvt0O0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:37 INFO - Running setup.py (path:/tmp/pip-58tAKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:37 INFO - Running setup.py (path:/tmp/pip-QlRl9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:21:37 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)) 17:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:37 INFO - Running setup.py (path:/tmp/pip-ZZ3rZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:38 INFO - Running setup.py (path:/tmp/pip-4DW567-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:38 INFO - Running setup.py (path:/tmp/pip-YhNeea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 17:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:38 INFO - Running setup.py (path:/tmp/pip-Z4ia5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:39 INFO - Downloading blessings-1.5.1.tar.gz 17:21:39 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:21:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:21:39 INFO - Installing collected packages: blessings 17:21:39 INFO - Running setup.py install for blessings 17:21:40 INFO - Successfully installed blessings 17:21:40 INFO - Cleaning up... 17:21:40 INFO - Return code: 0 17:21:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:21:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:21:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:21:40 INFO - Reading from file tmpfile_stdout 17:21:40 INFO - Current package versions: 17:21:40 INFO - argparse == 1.2.1 17:21:40 INFO - blessings == 1.5.1 17:21:40 INFO - blobuploader == 1.2.4 17:21:40 INFO - docopt == 0.6.1 17:21:40 INFO - manifestparser == 1.1 17:21:40 INFO - mozInstall == 1.12 17:21:40 INFO - mozcrash == 0.16 17:21:40 INFO - mozdebug == 0.1 17:21:40 INFO - mozdevice == 0.47 17:21:40 INFO - mozfile == 1.2 17:21:40 INFO - mozhttpd == 0.7 17:21:40 INFO - mozinfo == 0.9 17:21:40 INFO - mozleak == 0.1 17:21:40 INFO - mozlog == 3.0 17:21:40 INFO - moznetwork == 0.27 17:21:40 INFO - mozprocess == 0.22 17:21:40 INFO - mozprofile == 0.27 17:21:40 INFO - mozrunner == 6.11 17:21:40 INFO - mozscreenshot == 0.1 17:21:40 INFO - mozsystemmonitor == 0.0 17:21:40 INFO - moztest == 0.7 17:21:40 INFO - mozversion == 1.4 17:21:40 INFO - psutil == 3.1.1 17:21:40 INFO - requests == 1.2.3 17:21:40 INFO - wsgiref == 0.1.2 17:21:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:21: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')]} 17:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe86395dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27376c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, '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': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', '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 17:21:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:21:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:21:40 INFO - Using env: {'DISPLAY': ':0', 17:21:40 INFO - 'HOME': '/home/cltbld', 17:21:40 INFO - 'LANG': 'en_US.UTF-8', 17:21:40 INFO - 'LANGUAGE': 'en_US:en', 17:21:40 INFO - 'LOGNAME': 'cltbld', 17:21:40 INFO - 'MAIL': '/var/mail/cltbld', 17:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:40 INFO - 'MOZ_NO_REMOTE': '1', 17:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:40 INFO - 'NO_EM_RESTART': '1', 17:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:40 INFO - 'SHELL': '/bin/bash', 17:21:40 INFO - 'SHLVL': '1', 17:21:40 INFO - 'TERM': 'linux', 17:21:40 INFO - 'TMOUT': '86400', 17:21:40 INFO - 'USER': 'cltbld', 17:21:40 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:40 INFO - '_': '/tools/buildbot/bin/python'} 17:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:21:40 INFO - Cleaning up... 17:21:40 INFO - Return code: 0 17:21:40 INFO - Running post-action listener: _resource_record_post_action 17:21:40 INFO - Running post-action listener: _start_resource_monitoring 17:21:40 INFO - Starting resource monitoring. 17:21:40 INFO - ##### 17:21:40 INFO - ##### Running install step. 17:21:40 INFO - ##### 17:21:40 INFO - Running pre-action listener: _resource_record_pre_action 17:21:40 INFO - Running main action method: install 17:21:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:21:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:21:40 INFO - Reading from file tmpfile_stdout 17:21:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:21:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:21:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:21:40 INFO - Reading from file tmpfile_stdout 17:21:40 INFO - Output received: 17:21:40 INFO - Usage: mozinstall [options] installer 17:21:40 INFO - Options: 17:21:40 INFO - -h, --help show this help message and exit 17:21:40 INFO - -d DEST, --destination=DEST 17:21:40 INFO - Directory to install application into. [default: 17:21:40 INFO - "/builds/slave/test-pgo"] 17:21:40 INFO - --app=APP Application being installed. [default: firefox] 17:21:40 INFO - mkdir: /builds/slave/test-pgo/build/application 17:21:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:21:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:21:55 INFO - Reading from file tmpfile_stdout 17:21:55 INFO - Output received: 17:21:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:21:55 INFO - Running post-action listener: _resource_record_post_action 17:21:55 INFO - ##### 17:21:55 INFO - ##### Running run-tests step. 17:21:55 INFO - ##### 17:21:55 INFO - Running pre-action listener: _resource_record_pre_action 17:21:55 INFO - Running main action method: run_tests 17:21:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:21:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:21:55 INFO - Python 2.7.3 17:21:55 INFO - Return code: 0 17:21:55 INFO - grabbing minidump binary from tooltool 17:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:21:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282dd70>, '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 0x282eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282efb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:21:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 17:21:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:21:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:21:55 INFO - Return code: 0 17:21:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:21:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:21:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:21:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:21:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:21:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 17:21:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 17:21:55 INFO - Using env: {'DISPLAY': ':0', 17:21:55 INFO - 'HOME': '/home/cltbld', 17:21:55 INFO - 'LANG': 'en_US.UTF-8', 17:21:55 INFO - 'LANGUAGE': 'en_US:en', 17:21:55 INFO - 'LOGNAME': 'cltbld', 17:21:55 INFO - 'MAIL': '/var/mail/cltbld', 17:21:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:21:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:55 INFO - 'MOZ_NO_REMOTE': '1', 17:21:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:55 INFO - 'NO_EM_RESTART': '1', 17:21:55 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:21:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:21:55 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:21:55 INFO - 'SHELL': '/bin/bash', 17:21:55 INFO - 'SHLVL': '1', 17:21:55 INFO - 'TERM': 'linux', 17:21:55 INFO - 'TMOUT': '86400', 17:21:55 INFO - 'USER': 'cltbld', 17:21:55 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624', 17:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:55 INFO - '_': '/tools/buildbot/bin/python'} 17:21:55 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 17:21:55 INFO - mozversion INFO | application_buildid: 20151118154238 17:21:55 INFO - mozversion INFO | application_changeset: e8c43ec095e309c1b11fb62be41cf3bd22f30e01 17:21:55 INFO - mozversion INFO | application_display_name: Nightly 17:21:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:21:55 INFO - mozversion INFO | application_name: Firefox 17:21:55 INFO - mozversion INFO | application_remotingname: firefox 17:21:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:21:55 INFO - mozversion INFO | application_vendor: Mozilla 17:21:55 INFO - mozversion INFO | application_version: 45.0a1 17:21:55 INFO - mozversion INFO | platform_buildid: 20151118154238 17:21:55 INFO - mozversion INFO | platform_changeset: e8c43ec095e309c1b11fb62be41cf3bd22f30e01 17:21:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:21:55 INFO - mozversion INFO | platform_version: 45.0a1 17:21:55 INFO - 2015-11-18 17:21:55,564 DEBUG : using testdate: 1447896115 17:21:55 INFO - 2015-11-18 17:21:55,564 DEBUG : actual date: 1447896115 17:21:55 INFO - 2015-11-18 17:21:55,573 INFO : starting webserver on 'localhost:50717' 17:21:55 INFO - 2015-11-18 17:21:55,573 INFO : Starting test suite talos-linux64-ix-061 17:21:55 INFO - 2015-11-18 17:21:55,574 INFO : Starting test dromaeo_css 17:21:55 INFO - 2015-11-18 17:21:55,574 DEBUG : operating with platform_type : linux_ 17:21:55 INFO - 2015-11-18 17:21:55,574 INFO : Initialising browser for dromaeo_css test... 17:21:55 INFO - 2015-11-18 17:21:55,592 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBeQFId/profile http://localhost:50717/getInfo.html 17:21:59 INFO - 2015-11-18 17:21:59,630 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:21:59 INFO - 2015-11-18 17:21:59,630 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:21:59 INFO - 2015-11-18 17:21:59,630 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:21:59 INFO - 2015-11-18 17:21:59,630 DEBUG : BROWSER_OUTPUT: __metrics 17:21:59 INFO - 2015-11-18 17:21:59,751 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:22:00 INFO - 2015-11-18 17:22:00,962 INFO : Browser initialized. 17:22:00 INFO - 2015-11-18 17:22:00,962 INFO : Running cycle 1/1 for dromaeo_css test... 17:22:00 INFO - 2015-11-18 17:22:00,962 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBeQFId/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:22:12 INFO - 2015-11-18 17:22:12,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 138240000 17:22:12 INFO - 2015-11-18 17:22:12,725 DEBUG : BROWSER_OUTPUT: 17:23:04 INFO - 2015-11-18 17:23:04,259 DEBUG : BROWSER_OUTPUT: 1447896184258 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] 17:25:12 INFO - 2015-11-18 17:25:12,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50717/tests/dromaeo/cssquery-ext.html) 17:25:13 INFO - 2015-11-18 17:25:13,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 236228608 17:25:13 INFO - 2015-11-18 17:25:13,612 DEBUG : BROWSER_OUTPUT: 17:28:15 INFO - 2015-11-18 17:28:15,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/dromaeo/cssquery-ext.html (next: http://localhost:50717/tests/dromaeo/cssquery-jquery.html) 17:28:16 INFO - 2015-11-18 17:28:16,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 226168832 17:28:16 INFO - 2015-11-18 17:28:16,527 DEBUG : BROWSER_OUTPUT: 17:31:18 INFO - 2015-11-18 17:31:18,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50717/tests/dromaeo/cssquery-mootools.html) 17:31:18 INFO - 2015-11-18 17:31:18,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 220368896 17:31:18 INFO - 2015-11-18 17:31:18,967 DEBUG : BROWSER_OUTPUT: 17:34:20 INFO - 2015-11-18 17:34:20,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50717/tests/dromaeo/cssquery-prototype.html) 17:34:21 INFO - 2015-11-18 17:34:21,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 202395648 17:34:21 INFO - 2015-11-18 17:34:21,444 DEBUG : BROWSER_OUTPUT: 17:37:23 INFO - 2015-11-18 17:37:23,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50717/tests/dromaeo/cssquery-yui.html) 17:37:24 INFO - 2015-11-18 17:37:24,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 204570624 17:37:24 INFO - 2015-11-18 17:37:24,523 DEBUG : BROWSER_OUTPUT: 17:40:26 INFO - 2015-11-18 17:40:26,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/dromaeo/cssquery-yui.html (next: http://localhost:50717/tests/dromaeo/cssquery-dojo.html) 17:40:27 INFO - 2015-11-18 17:40:27,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 263917568 17:40:27 INFO - 2015-11-18 17:40:27,108 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,108 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:40:27 INFO - 2015-11-18 17:40:27,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:40:27 INFO - 2015-11-18 17:40:27,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:40:27 INFO - 2015-11-18 17:40:27,108 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:40:27 INFO - 2015-11-18 17:40:27,108 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3221.9355612887744;3270.9018729438126;3304.933901321975;3308.305255896262;3323.8670453181876;5234.476552344764;5328.1474964005765;5419.214213938976;5460.126379779231;5482.314710661162;5278.762455689493;5330.3603567571945;5338.412774594792;5367.919481207775;5498.3127109111365;4896.9471563613815;4903.583195428384;4959.975200123994;4992.67547609406;5083.822066227683;4863.489333619972;4976.87557811054;4985.775640096186;5058.721770302632;5076.340075790161;4920.114379411704;4981.750912454381;4986.650934434591;5022.974885125587;5048.192289233742;4959.628027897886;4975.203967365241;4983.401991760976;5022.84931452057;5024.472430394829;4800.375951126366;4902.3872015998;4957.752112394366;4978.054169707744;5021.59827213822;5209.557187639055;5298.337707786527;5316.255724198615;5326.520613144797;5328.653637513549;5906.616069955439;5935.317438494542;5936.762529498815;5949.018411962021;5957.6127551709;5741.540676745851;5795.536357091422;5969.940300596982;5980.880382392328;6000.309964354112;5539.889202215933;5548.611597188158;5549.278593782782;5552.972235138839;5560.527355174815;6034.426729460782;6038.969805150946;6052.152698622196;6058.757649693963;6059;5617.494425501724;5737.3688894221605;5799.739011744482;5843.29880414353;5906.379830117861;5921.141434491975;5922.378150294243;5929.407059294036;5929.673867937305;5935.376785437467;5891.970540147272;5898.085796701518;5901.793437229677;5906.143609176731;5907.320658124285;5699.572532060112;5789.218455508452;5828.970855145697;5890.175375447441;5931.199288096138;4532.274836026286;4534.433195850519;4554.681172317973;4570.8171673133365;4619.907601848012;4024.335984562573;4027.335489644176;4029.0330320722815;4033.3546632538655;4070.063885306337;5425.538829199483;5526.088195447706;5533.7786488540005;5567.498925096761;5651.632643878134;5860.472557469763;5940.881182376328;5945.227120474311;5953.434423729739;5957.731902064417;5589.524890384281;5594.832155035356;5597.964376590262;5598.524125449382;5602.215689803431;5028.622853286018;5109.923351149736;5148.510891465305;5188.455212202664;5235.502627250406;6175.96912015437;6194.34959329273;6200.937990620036;6205.348438413992;6208.317085120633;5690.687012214368;5950.166976623363;5977.551683623833;5981.790637327673;5983.730732116978;5886.05823068307;5911.940880591311;5953.702314884152;5995.820125396245;6060.181875446759;5824.708764561839;5856.502197313276;5864.853378665397;5865.090910908816;5873.559483038704;5790.305163380252;5929.407059294209;5930.347661757117;5951.107333899777;5952.434518720715;5669.064604340238;5737.540996720169;5751.654900705971;5754.3382511010095;5796.739146738491;5722.7710891563875;5732.16883551891;5732.197492350991;5735.254416925773;5773.595848290747;5459.044667183148;5581.441855814386;5589.077802162597;5607.495325420732;5622;5777.2200752897825;5860.501857342174;5866.794662186803;5880.441358070976;5889.764409423575;5656.490915817596;5657.43425657431;5663.745131469176;5681.261436013458;5681.573881958787 17:40:27 INFO - 2015-11-18 17:40:27,109 DEBUG : BROWSER_OUTPUT: |1;ext.html;590.4449817171858;595.1875689683582;603.3875616249508;608.2427377914495;614.2230078950126;32465.350692986125;38365.23269534611;38811.223775524544;38816.223675526475;38822.99999999996;44058.77970610151;44337.113257734825;44385.11229775403;44460.11079778402;44830.32754508685;7550.6979720811105;7697.653605587734;8666.696665616704;8840.911590884074;8844.778880528007;10412.062914337708;10733.141348692086;10735.838962415532;10737.946310268439;10742.892571074306;10412.791744165112;10509.159267258601;10529.15766738663;10578.206634502405;10582.365058096539;7804.141544430108;8023.197680231989;10373.222008349328;10425.635102771404;10490.108340791005;10335.173186145166;10475.633352832614;10488.68533943983;10489.055984961391;10492.632757853438;39715.80142099271;40125.197496049914;40202.798986005175;40212.39681404781;40235.59764402348;3381.120908563791;3537.911552211215;3772.0192749884955;3902.863399780994;4197.055662475918;30268.394632107236;30350.241243969078;30727.231819204477;31309.217269568442;31539.21151971196;3619.0952261934517;3686.889393318205;3687.3362794696945;3726.739128261023;3791.317562838688;277279;277632;278994;279100;279544;54292.45707542874;55452.72273638606;60667;61212.693936530035;66696.66651666808;60865.69567152225;60887.39112608906;61125.69437152786;61143;61153;14455.349509272108;14543.3455494503;14580.635484112981;14600.561983140522;14604.415823367159;11208.439578021067;11360.829587556193;11398.031167350702;11410;11425.542978280942;19957.700634490495;20177.192912283637;20242.805755395624;20250.088746006466;20259.797402026084;7527.172011078777;7716.382689384835;7772.727954521564;7773.106092799288;7808.492447990862;860.049645142109;940.6378544260372;977.9462129582942;1029.6036026129993;1043.3687618990552;26565.734342656713;27001.189964301102;27048.59427108595;28004.43991120166;28365.71634283631;986.3539381704994;993.9105480506789;1066.6320119558895;1084.2301965604352;1133.4049623947328;14179.22014289224;14181.432742690384;14210.715785684228;14393.64015899611;14408.279586020657;271515;274115;274789;274880;275876;48224.27663585049;48505;48507.757461212466;48532.27201591979;48533;1363.8840698540735;1370.595674276091;1372.499037851177;1379.5102738527878;1384.8753612174953;27215.319617009733;28123.57814632741;28257.43485130327;28258.15225543237;29564.408711826072;45124.32313515365;46127.76936115432;46315;47098.76450617725;50399;227606;228847;229182;230259;230556;29796.85101574565;30419.39161216719;30425.695743042284;30441.695583044773;30528.236794080327;35263.64736352706;41076;44163.77918110389;44621.77689111534;45060.54939450695;35486.46770298396;35515.82242088773;36999.445008325434;37827;37997.620023799405;35020;35188.296234075686;35308.82345588256;35342.82328588341;35382;34727.30545389027;36591;36599.26801464009;36821.81589092038;36839.079023023565;28868;30872.84563577168;31266.53100203544;31520.369592608477;31597.368052639278;24393.756062439857;24404.75595244025;24453.877730611945;24536.141235056686;24714.258572242863 17:40:27 INFO - 2015-11-18 17:40:27,109 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.0138604975819;348.783754072475;352.1302383113708;353.4909729988816;356.54006331831937;14775.187364694937;14791.408343666268;16778.41275555354;17026.14869256537;17766.911165444188;15666.608334791636;16253.18734063295;16403.343866245337;16921.576960575992;16929.746053809173;4703.670743047979;5413.458654134594;5414.8917021659545;5415.810446634368;5423.132298832187;3974.4634474346026;4079.1229885574594;5369.543588794957;5408.648437851547;5768.971155144219;5793.449622285876;5860.882782344372;5880.970595147019;5881.470667639912;5883.529317654577;5528.806491772789;5855.238818953551;5898.882022359572;5906.822795316148;5912.290525137011;5200.089984252779;5221.921671174935;5226.425093239741;5228.55557277628;5231.110711179071;20174;20642.27752028687;20671.069801858954;21025.369238922856;21154.826775983573;2142.2287976328507;2172.4134483689472;2199.82401407887;2309.226409152936;2565.371483986435;13137.540186093536;13399;13530.526431574848;13585.59243222695;13663.316834158351;1771.9911400443045;1850.421765474633;1857.7027675571844;1858.3310008396966;1879.7462342583713;58801.41198588002;59933.40066599322;59965;60055;60956;9486.90513094874;9698.272629552812;9890.258230632731;9894.653687120915;9933.850992235122;12837.229766214057;12841;12860.742785144432;12864.678383040498;12876.871231287754;7743.7676869694;7751.302382785577;7805.180456052033;7805.453618246668;7919.247671471201;7658.61706914652;7660.119086305035;7741.7677469676;7766.883496747553;7790.143084260727;5913.113033045078;5990.251218597676;6022.307434644984;6047.879042419215;6078.848028799315;1624.3259047495394;1673.1634182908547;1682.8569571586308;1685.7977042754703;1734.2716059255142;926.1892999186574;936.578539657157;961.2598299309493;979.480875136179;984.684900831727;14991.700165996619;16516.17419129039;17056.147192640317;17200;17423.390181343846;978.1245785022508;979.6228452045871;989.7674046599044;1003.6738060130486;1044.5404022230193;10149.949250253701;10191.7452063699;10338.431386273676;10419.426931518688;10430.582776689;510410;518374;518799;521631;529956;70676;73241;73430.12558995267;74076;74713;1151.8848115188582;1158.8030034894089;1161.4192903548226;1168.1589255735857;1169.7894379011689;15491.612709681896;15522.22388880574;15590.22048897528;15765.132917689638;15966.600834978753;30887.691123089382;34963.951081467596;35328;36028.639713603574;36552.45171322486;38325.42511862268;38363.616363836;40644.39033414442;40922.79538602288;41033.384499233136;6813.8637227254185;6929.445644348541;6971.825704357431;6972.546784458994;6980.267071957372;10450.320729152885;12362.690932726753;12494.937525312314;12748.171368861365;12785.74428511406;9274.072592740671;10685.732856678645;10770.246082774443;10841.295315804447;11037.227394082338;10598.523066461874;11031.22781405326;11043.779124417628;11064.114870810477;11352.772944541228;11009.61466348674;11259.718507037389;11353.943230283796;11379.487923043649;11464.94267528657;6819.318068193141;6941.34057264559;6942.618156001468;6942.791716248521;6968.884978403431;10658.253922225369;10678.199135064746;10700.518476668412;10813.67558973232;11216.046636035702 17:40:27 INFO - 2015-11-18 17:40:27,110 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1329.7672907241242;1445.4579532675248;1478.1426772471964;1618.9271482783274;1767.6199617082325;6692.063111164435;7713.190115037924;7846.960765196181;7873.173316801739;7895.131535531087;7625.31372176504;7739.226077392258;7754.961225193881;7758.030246219223;7764.534127952327;1978.465814230157;2038.2764118737857;2041.2855500574829;2294.369048511656;2333.57995560799;2062.6802845558964;2281.634938409855;2329.2779238436055;2330.2426711318803;2331.755165707602;2238.0488292475716;2253.22263818983;2259.9096036158535;2302.96545551816;2308.088305119485;1997.6404247235491;2040.9285675001304;2298.6437102249092;2324.244620498336;2327.2669109230624;2268.319504148765;2316.397736588499;2321.4776675247936;2323.1288266899915;2326.3137374474572;7658.081030276402;7821.2960833524685;7834.138244793068;7843.33331666809;7852.136265010901;4677.368555245032;4764.213904705719;4777.163996300634;4789.544993225638;4794.496577859344;2992.8204307741607;3142.937141257185;3144.308252184516;3166.509191075387;3172.841357932094;1060.8461773042943;1120.383788916093;1914.3682584747;1967.3802752133033;1991.9701204481944;10771.299865508796;10842.512086956027;10865.782684346348;10905.073068789163;10932.344059356465;4177.707560470799;4248.87253382399;4259.9574004260185;4298.312270036779;4322.438083049184;8763.780905477413;8841.823163536694;8858.73423797287;8883.600237989305;8896.822063558693;4725.653188841164;4725.9527404726205;4730.053989202173;4733.692309999839;4739.170645137087;4383.167198232326;4401.1417773534495;4420.491643460979;4433.467983841895;4435.600795928382;3439.2949445363643;3506.9298614027575;3541.451075083366;3549.4853246279145;3555.5733312002208;1088.6733979806027;1094.1192340166242;1096.5997410944947;1103.3269705479652;1104.2160066352978;1267.0813660096542;1272.1031672670745;1280.475005247844;1299.2009913902882;1305;7476.626168691544;7520.135184453858;7537.585432801248;7543.698252069966;7553.471257012066;506.010748985732;508.12855952042423;1189.851268591426;1218.5004148299154;1230.3479156047308;5252;5324.8136315228785;5770.24986751728;6071.241094863142;6161.630302181883;9188.173064424234;9281.814363712689;9405.529723513797;9449.763755906157;9451.858222126673;9268.119528644767;9273.443593384418;9302.720918372459;9398.624055037859;9437.480938548308;7204.675789589481;7366.410687145016;7410.221926697727;7410.925890741131;7456.32893039629;7185.856282874209;7217.278272172951;7231.927680723125;7234.855302893808;7238.963805180941;7961.522308661499;8064.516129032277;8211.548364839991;8278.875816862632;8298.502089874626;8343.249107580346;8414.663413463637;8474.406791524534;8562.657493700432;8595.65617375298;6910.585364878123;6923.9653801730665;6972.965135174291;6993.125859267591;7072.08062951813;7526.285002924714;7528.774136775905;7563.7352692655495;7581.696732130653;7582.62086895642;6940.340667636567;7053.435725141873;7062.258462861531;7142.392896603639;7174.713011479483;6968.303169682991;6977.825554361181;7004.719811207495;7062.329078737512;7104.360607545345;7031.332023457763;7085.185203701434;7136.0723105995885;7150.892736609059;7167.462440316893;6538.084668146368;6555.541112122106;6581.769638062645;6589.4728421725185;6592.967035164986;6430.871382572416;6488.513361497812;6550.737970481318;6552.475801935929;6555.901661475177 17:40:27 INFO - 2015-11-18 17:40:27,111 DEBUG : BROWSER_OUTPUT: |4;prototype.html;337.9425497665397;340.65593750312183;340.99147521311966;341.93503234385463;345.48005252095595;5958.553108516868;6099.390060993898;6154.784582539612;6166.167567378403;6174.259088909332;5908.822735317947;6083.847903802407;6093.207882975207;6093.817185484431;6095.116208149816;4639.257718764999;4676.602488788449;4682.8126874924965;4694.0611877624615;4699.788509517063;4473.776311184444;4549.545045495441;4566.246569316058;4670.1126785910565;4683.180443422404;4575.473820510634;4619.284010978304;4622.468416132154;4625.953740462603;4634.258518637019;4626.565764612981;4630.143423466669;4640.651951103664;4644.326572646981;4660.1145782301255;4030.1133750574827;4065.4308396824467;4068.816903239361;4080.326746086892;4087.632113109805;5665.206871038017;5806.6225695330095;5811.302643682743;5836.533077353844;5859.238299021143;5467.234587157801;5489.890202195934;5494.752736126884;5495.010898038351;5505.724713764336;6505.918106206016;6516.0877477153235;6521.184851893513;6526.804195874131;6527.02094685801;4356.237658409797;4563.452385713736;4565.223911934946;4565.292379681155;4568.954310456887;6771.390574848238;6852.383285504278;6853.280405557444;6853.725850965955;6861.176658800926;4603.8618841434145;4604.723716577016;4605.746683932416;4607.216773148572;4611;4651.1162879053545;4660.627149828006;4663.696859704109;4663.766811659403;4670.369500117441;5300.628955973045;5410.540104091197;5417.187421886749;5419.376771671229;5425.457454254543;6575.638339891256;6585.209774827052;6587.242467116247;6588.901166482507;6594.7032383542855;1627.3409269245974;1638.9344426222817;1643.1784107946028;1644.4244514419856;1644.5888527868033;1075.93544387337;1081.853949716794;1083.0469187115289;1083.5286650306984;1108.9500972456258;6326.715297811609;6332.018537126753;6352.396522330371;6359.046143078575;6363.490920726331;6538.967305163444;6629.966850165718;6645.903425934764;6744.325567443315;6804.897926531106;6314;6325.588836725598;6326.652034138075;6337.271213810471;6411.685604451076;3668.63313668631;3698.3342998260573;3700.555933287969;3700.9259814803554;3709.684676802502;6913.170419549686;7106.822329441805;7110.537815042006;7112.502124851314;7130.42956563484;7000.614966176808;7008.299170082951;7013.509054366145;7014.438844892396;7027.8594428111155;7107.964460177769;7110.431165506747;7111.64441777909;7118.25258347866;7123.857522849617;6653.933460665331;6808.7276508939085;6815;6818.318168183142;6828.487863410165;6669.866602667822;6713.496487763339;6735.225449073223;6754.763583274562;6758.695858686273;7103.857922841411;7105.360517553445;7113.75101871432;7114.466415018791;7116.608586527791;4477.126960242721;4561.042181141865;4568.840090596813;4572.839950601713;4611;6743.426808721314;6776.186857577122;6791.049253104668;6791.117154769849;6795.898061528982;6584.670766461562;6586.571872828251;6587.901181482186;6594.076829244005;6601.570897891622;6401.29585745577;6590.308017658269;6621.470282377302;6642.036904648702;6643.202815662152;6495.382938620824;6500.219973603198;6510.381513756186;6516.283208846929;6527.05357723118;6663;6663.233728121134;6671.499637527302;6677.532572719863;6677.69950352245;6221.906671400023;6284.937150628435;6295.433410993032;6479.125318082187;6506.512011599054 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: |5;yui.html;739.7447880481232;783.3028604541959;847.3052097280229;884.8009197930464;892.2460520859876;13506;13808.861911380884;13882.722345553095;14496.565103046925;14529.273536323168;14385.352659130338;14494.710105797878;14499.420023199085;14504.202268875208;14506.564803055899;704.3590332797156;711.5339452658517;851.216880469966;865.355310293832;865.7792262972933;845.8096928191138;853.6030745703247;859.6776208921623;859.7893516088536;860.8966923969133;892.1970226795871;899.5142622983581;900.1088921967238;901.5221932375819;903.0969030969031;732.0483371616904;734.3024127079296;864.6109250837148;881.2421317666801;898.9910100898973;647.7311915555039;651.1567520061532;651.2250421997808;651.2770824384929;651.5243871973438;12763.680907977281;12841.486340546368;12873.22760634365;12877.742445151045;12891.548795792196;12426.689332766662;12519.43662535188;12796.680082997906;12866.228026318451;13518.188908665414;10581.36511809294;10779.892201078046;10829.350238985686;10941.507632156492;11001.17491188164;3532.6467353264725;3713;3729.160938788778;3784.489093972306;3880.06878349197;44649.330260046125;44859.32711009338;44952.100957980656;45093.77453112746;45138.09723805539;10342.844857327145;10366.378017318984;10427.426491543038;10457.372557646566;10691.946540267405;19468.902655486632;19619.509512262306;19639.705404418946;19647.31234406789;19688.90155549213;7917.524948503108;7943.364530837519;7971.681132754741;8027.839443211103;8039.276465118168;4248.553901840324;4302.827886884552;4361.062371590124;4372.23485889968;4393.472783265965;3246.0748686624197;3253.024092772159;3274.1323549259464;3284.3595498877967;3286.76992610515;475.6028716022091;493.2404097689518;494.3079688436146;500.5170010939461;509.5846884788885;602.0758136260819;701.2216439751871;731.0897932074495;747.0922828763079;749.5914726474085;8607.311415086779;8765.649374025095;9160.038195989458;9348.90651093494;10065.276690387034;708.2563308526027;708.4686485136148;710.9360157585738;723.489939592586;741.2032065529577;4133.338665813455;4211.241976444269;4253.447051883235;4258.68059895509;4394.934075988863;54303;54966.725166374716;61799.6910015456;61836;62028.069578956354;51120.233196502086;51861.48138518642;52148.21777673338;52377.2143417849;52988;48553.757231214324;48821.75589122032;48971;49635.751821241385;49961.25058124131;9000.189982901571;9043;9306.813863722824;9357.44670265424;9410.43537387759;36912.81543592265;37015.25969480649;37175.628243718296;37397.439038413904;38062.619373807014;41840.071195016055;47189.764051179525;47322.29016564685;47413.28880066733;47832;11932.70168245766;11959.282443053444;11971.221870578385;11977.940110299392;12489.687757806127;12729.80905286403;12857.807132893202;12884.677883052998;12945.935270323587;12984;11614.709632258922;11693.473793679135;12528.561500347445;12579.937100314806;12600.495980160691;11770.882291176978;12063.396830158632;12081.879181208076;12428.254304741744;12457.314847683465;10628.52171652262;10812.67561973142;10817.729556761144;10893.183011274345;11121.944390277997;9953.153981911619;9964;10081.092701656886;10086.092251697382;10112.039356261143;9318.487483188219;9338.766530836783;9514.952425237829;9908.554115064695;10059.69820905374 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: __startTimestamp1447897227100__endTimestamp 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:40:27 INFO - 2015-11-18 17:40:27,115 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5463.84 Median:5657.43 stddev:614.57 (10.9%) stddev-sans-first:590.75 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: Values: 3221.9 3270.9 3304.9 3308.3 3323.9 5234.5 5328.1 5419.2 5460.1 5482.3 5278.8 5330.4 5338.4 5367.9 5498.3 4896.9 4903.6 4960.0 4992.7 5083.8 4863.5 4976.9 4985.8 5058.7 5076.3 4920.1 4981.8 4986.7 5023.0 5048.2 4959.6 4975.2 4983.4 5022.8 5024.5 4800.4 4902.4 4957.8 4978.1 5021.6 5209.6 5298.3 5316.3 5326.5 5328.7 5906.6 5935.3 5936.8 5949.0 5957.6 5741.5 5795.5 5969.9 5980.9 6000.3 5539.9 5548.6 5549.3 5553.0 5560.5 6034.4 6039.0 6052.2 6058.8 6059.0 5617.5 5737.4 5799.7 5843.3 5906.4 5921.1 5922.4 5929.4 5929.7 5935.4 5892.0 5898.1 5901.8 5906.1 5907.3 5699.6 5789.2 5829.0 5890.2 5931.2 4532.3 4534.4 4554.7 4570.8 4619.9 4024.3 4027.3 4029.0 4033.4 4070.1 5425.5 5526.1 5533.8 5567.5 5651.6 5860.5 5940.9 5945.2 5953.4 5957.7 5589.5 5594.8 5598.0 5598.5 5602.2 5028.6 5109.9 5148.5 5188.5 5235.5 6176.0 6194.3 6200.9 6205.3 6208.3 5690.7 5950.2 5977.6 5981.8 5983.7 5886.1 5911.9 5953.7 5995.8 6060.2 5824.7 5856.5 5864.9 5865.1 5873.6 5790.3 5929.4 5930.3 5951.1 5952.4 5669.1 5737.5 5751.7 5754.3 5796.7 5722.8 5732.2 5732.2 5735.3 5773.6 5459.0 5581.4 5589.1 5607.5 5622.0 5777.2 5860.5 5866.8 5880.4 5889.8 5656.5 5657.4 5663.7 5681.3 5681.6 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43657.07 Median:31529.79 stddev:68053.60 (215.8%) stddev-sans-first:68167.68 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: Values: 590.4 595.2 603.4 608.2 614.2 32465.4 38365.2 38811.2 38816.2 38823.0 44058.8 44337.1 44385.1 44460.1 44830.3 7550.7 7697.7 8666.7 8840.9 8844.8 10412.1 10733.1 10735.8 10737.9 10742.9 10412.8 10509.2 10529.2 10578.2 10582.4 7804.1 8023.2 10373.2 10425.6 10490.1 10335.2 10475.6 10488.7 10489.1 10492.6 39715.8 40125.2 40202.8 40212.4 40235.6 3381.1 3537.9 3772.0 3902.9 4197.1 30268.4 30350.2 30727.2 31309.2 31539.2 3619.1 3686.9 3687.3 3726.7 3791.3 277279.0 277632.0 278994.0 279100.0 279544.0 54292.5 55452.7 60667.0 61212.7 66696.7 60865.7 60887.4 61125.7 61143.0 61153.0 14455.3 14543.3 14580.6 14600.6 14604.4 11208.4 11360.8 11398.0 11410.0 11425.5 19957.7 20177.2 20242.8 20250.1 20259.8 7527.2 7716.4 7772.7 7773.1 7808.5 860.0 940.6 977.9 1029.6 1043.4 26565.7 27001.2 27048.6 28004.4 28365.7 986.4 993.9 1066.6 1084.2 1133.4 14179.2 14181.4 14210.7 14393.6 14408.3 271515.0 274115.0 274789.0 274880.0 275876.0 48224.3 48505.0 48507.8 48532.3 48533.0 1363.9 1370.6 1372.5 1379.5 1384.9 27215.3 28123.6 28257.4 28258.2 29564.4 45124.3 46127.8 46315.0 47098.8 50399.0 227606.0 228847.0 229182.0 230259.0 230556.0 29796.9 30419.4 30425.7 30441.7 30528.2 35263.6 41076.0 44163.8 44621.8 45060.5 35486.5 35515.8 36999.4 37827.0 37997.6 35020.0 35188.3 35308.8 35342.8 35382.0 34727.3 36591.0 36599.3 36821.8 36839.1 28868.0 30872.8 31266.5 31520.4 31597.4 24393.8 24404.8 24453.9 24536.1 24714.3 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27424.97 Median:352.81 stddev:84896.95 (24063.0%) stddev-sans-first:85110.76 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: Values: 346.0 348.8 352.1 353.5 356.5 14775.2 14791.4 16778.4 17026.1 17766.9 15666.6 16253.2 16403.3 16921.6 16929.7 4703.7 5413.5 5414.9 5415.8 5423.1 3974.5 4079.1 5369.5 5408.6 5769.0 5793.4 5860.9 5881.0 5881.5 5883.5 5528.8 5855.2 5898.9 5906.8 5912.3 5200.1 5221.9 5226.4 5228.6 5231.1 20174.0 20642.3 20671.1 21025.4 21154.8 2142.2 2172.4 2199.8 2309.2 2565.4 13137.5 13399.0 13530.5 13585.6 13663.3 1772.0 1850.4 1857.7 1858.3 1879.7 58801.4 59933.4 59965.0 60055.0 60956.0 9486.9 9698.3 9890.3 9894.7 9933.9 12837.2 12841.0 12860.7 12864.7 12876.9 7743.8 7751.3 7805.2 7805.5 7919.2 7658.6 7660.1 7741.8 7766.9 7790.1 5913.1 5990.3 6022.3 6047.9 6078.8 1624.3 1673.2 1682.9 1685.8 1734.3 926.2 936.6 961.3 979.5 984.7 14991.7 16516.2 17056.1 17200.0 17423.4 978.1 979.6 989.8 1003.7 1044.5 10149.9 10191.7 10338.4 10419.4 10430.6 510410.0 518374.0 518799.0 521631.0 529956.0 70676.0 73241.0 73430.1 74076.0 74713.0 1151.9 1158.8 1161.4 1168.2 1169.8 15491.6 15522.2 15590.2 15765.1 15966.6 30887.7 34964.0 35328.0 36028.6 36552.5 38325.4 38363.6 40644.4 40922.8 41033.4 6813.9 6929.4 6971.8 6972.5 6980.3 10450.3 12362.7 12494.9 12748.2 12785.7 9274.1 10685.7 10770.2 10841.3 11037.2 10598.5 11031.2 11043.8 11064.1 11352.8 11009.6 11259.7 11353.9 11379.5 11464.9 6819.3 6941.3 6942.6 6942.8 6968.9 10658.3 10678.2 10700.5 10813.7 11216.0 17:40:27 INFO - 2015-11-18 17:40:27,116 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,117 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5480.31 Median:6459.69 stddev:2812.73 (43.5%) stddev-sans-first:2803.32 17:40:27 INFO - 2015-11-18 17:40:27,117 DEBUG : BROWSER_OUTPUT: Values: 1329.8 1445.5 1478.1 1618.9 1767.6 6692.1 7713.2 7847.0 7873.2 7895.1 7625.3 7739.2 7755.0 7758.0 7764.5 1978.5 2038.3 2041.3 2294.4 2333.6 2062.7 2281.6 2329.3 2330.2 2331.8 2238.0 2253.2 2259.9 2303.0 2308.1 1997.6 2040.9 2298.6 2324.2 2327.3 2268.3 2316.4 2321.5 2323.1 2326.3 7658.1 7821.3 7834.1 7843.3 7852.1 4677.4 4764.2 4777.2 4789.5 4794.5 2992.8 3142.9 3144.3 3166.5 3172.8 1060.8 1120.4 1914.4 1967.4 1992.0 10771.3 10842.5 10865.8 10905.1 10932.3 4177.7 4248.9 4260.0 4298.3 4322.4 8763.8 8841.8 8858.7 8883.6 8896.8 4725.7 4726.0 4730.1 4733.7 4739.2 4383.2 4401.1 4420.5 4433.5 4435.6 3439.3 3506.9 3541.5 3549.5 3555.6 1088.7 1094.1 1096.6 1103.3 1104.2 1267.1 1272.1 1280.5 1299.2 1305.0 7476.6 7520.1 7537.6 7543.7 7553.5 506.0 508.1 1189.9 1218.5 1230.3 5252.0 5324.8 5770.2 6071.2 6161.6 9188.2 9281.8 9405.5 9449.8 9451.9 9268.1 9273.4 9302.7 9398.6 9437.5 7204.7 7366.4 7410.2 7410.9 7456.3 7185.9 7217.3 7231.9 7234.9 7239.0 7961.5 8064.5 8211.5 8278.9 8298.5 8343.2 8414.7 8474.4 8562.7 8595.7 6910.6 6924.0 6973.0 6993.1 7072.1 7526.3 7528.8 7563.7 7581.7 7582.6 6940.3 7053.4 7062.3 7142.4 7174.7 6968.3 6977.8 7004.7 7062.3 7104.4 7031.3 7085.2 7136.1 7150.9 7167.5 6538.1 6555.5 6581.8 6589.5 6593.0 6430.9 6488.5 6550.7 6552.5 6555.9 17:40:27 INFO - 2015-11-18 17:40:27,117 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,117 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5476.91 Median:6253.42 stddev:1676.05 (26.8%) stddev-sans-first:1635.77 17:40:27 INFO - 2015-11-18 17:40:27,118 DEBUG : BROWSER_OUTPUT: Values: 337.9 340.7 341.0 341.9 345.5 5958.6 6099.4 6154.8 6166.2 6174.3 5908.8 6083.8 6093.2 6093.8 6095.1 4639.3 4676.6 4682.8 4694.1 4699.8 4473.8 4549.5 4566.2 4670.1 4683.2 4575.5 4619.3 4622.5 4626.0 4634.3 4626.6 4630.1 4640.7 4644.3 4660.1 4030.1 4065.4 4068.8 4080.3 4087.6 5665.2 5806.6 5811.3 5836.5 5859.2 5467.2 5489.9 5494.8 5495.0 5505.7 6505.9 6516.1 6521.2 6526.8 6527.0 4356.2 4563.5 4565.2 4565.3 4569.0 6771.4 6852.4 6853.3 6853.7 6861.2 4603.9 4604.7 4605.7 4607.2 4611.0 4651.1 4660.6 4663.7 4663.8 4670.4 5300.6 5410.5 5417.2 5419.4 5425.5 6575.6 6585.2 6587.2 6588.9 6594.7 1627.3 1638.9 1643.2 1644.4 1644.6 1075.9 1081.9 1083.0 1083.5 1109.0 6326.7 6332.0 6352.4 6359.0 6363.5 6539.0 6630.0 6645.9 6744.3 6804.9 6314.0 6325.6 6326.7 6337.3 6411.7 3668.6 3698.3 3700.6 3700.9 3709.7 6913.2 7106.8 7110.5 7112.5 7130.4 7000.6 7008.3 7013.5 7014.4 7027.9 7108.0 7110.4 7111.6 7118.3 7123.9 6653.9 6808.7 6815.0 6818.3 6828.5 6669.9 6713.5 6735.2 6754.8 6758.7 7103.9 7105.4 7113.8 7114.5 7116.6 4477.1 4561.0 4568.8 4572.8 4611.0 6743.4 6776.2 6791.0 6791.1 6795.9 6584.7 6586.6 6587.9 6594.1 6601.6 6401.3 6590.3 6621.5 6642.0 6643.2 6495.4 6500.2 6510.4 6516.3 6527.1 6663.0 6663.2 6671.5 6677.5 6677.7 6221.9 6284.9 6295.4 6479.1 6506.5 17:40:27 INFO - 2015-11-18 17:40:27,118 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,118 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14236.79 Median:24522.13 stddev:16256.23 (66.3%) stddev-sans-first:16270.23 17:40:27 INFO - 2015-11-18 17:40:27,118 DEBUG : BROWSER_OUTPUT: Values: 739.7 783.3 847.3 884.8 892.2 13506.0 13808.9 13882.7 14496.6 14529.3 14385.4 14494.7 14499.4 14504.2 14506.6 704.4 711.5 851.2 865.4 865.8 845.8 853.6 859.7 859.8 860.9 892.2 899.5 900.1 901.5 903.1 732.0 734.3 864.6 881.2 899.0 647.7 651.2 651.2 651.3 651.5 12763.7 12841.5 12873.2 12877.7 12891.5 12426.7 12519.4 12796.7 12866.2 13518.2 10581.4 10779.9 10829.4 10941.5 11001.2 3532.6 3713.0 3729.2 3784.5 3880.1 44649.3 44859.3 44952.1 45093.8 45138.1 10342.8 10366.4 10427.4 10457.4 10691.9 19468.9 19619.5 19639.7 19647.3 19688.9 7917.5 7943.4 7971.7 8027.8 8039.3 4248.6 4302.8 4361.1 4372.2 4393.5 3246.1 3253.0 3274.1 3284.4 3286.8 475.6 493.2 494.3 500.5 509.6 602.1 701.2 731.1 747.1 749.6 8607.3 8765.6 9160.0 9348.9 10065.3 708.3 708.5 710.9 723.5 741.2 4133.3 4211.2 4253.4 4258.7 4394.9 54303.0 54966.7 61799.7 61836.0 62028.1 51120.2 51861.5 52148.2 52377.2 52988.0 48553.8 48821.8 48971.0 49635.8 49961.3 9000.2 9043.0 9306.8 9357.4 9410.4 36912.8 37015.3 37175.6 37397.4 38062.6 41840.1 47189.8 47322.3 47413.3 47832.0 11932.7 11959.3 11971.2 11977.9 12489.7 12729.8 12857.8 12884.7 12945.9 12984.0 11614.7 11693.5 12528.6 12579.9 12600.5 11770.9 12063.4 12081.9 12428.3 12457.3 10628.5 10812.7 10817.7 10893.2 11121.9 9953.2 9964.0 10081.1 10086.1 10112.0 9318.5 9338.8 9515.0 9908.6 10059.7 17:40:27 INFO - 2015-11-18 17:40:27,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:40:27 INFO - 2015-11-18 17:40:27,119 DEBUG : BROWSER_OUTPUT: 17:40:27 INFO - 2015-11-18 17:40:27,810 INFO : Browser exited with error code: 0 17:40:27 INFO - 2015-11-18 17:40:27,829 INFO : Completed test dromaeo_css (00:18:32) 17:40:27 INFO - 2015-11-18 17:40:27,829 INFO : Starting test kraken 17:40:27 INFO - 2015-11-18 17:40:27,829 DEBUG : operating with platform_type : linux_ 17:40:27 INFO - 2015-11-18 17:40:27,829 INFO : Initialising browser for kraken test... 17:40:27 INFO - 2015-11-18 17:40:27,835 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQnum_t/profile http://localhost:50717/getInfo.html 17:40:31 INFO - 2015-11-18 17:40:31,581 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:40:31 INFO - 2015-11-18 17:40:31,581 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:40:31 INFO - 2015-11-18 17:40:31,581 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:40:31 INFO - 2015-11-18 17:40:31,581 DEBUG : BROWSER_OUTPUT: __metrics 17:40:31 INFO - 2015-11-18 17:40:31,738 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:40:33 INFO - 2015-11-18 17:40:33,004 INFO : Browser initialized. 17:40:33 INFO - 2015-11-18 17:40:33,005 INFO : Running cycle 1/1 for kraken test... 17:40:33 INFO - 2015-11-18 17:40:33,005 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQnum_t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:40:44 INFO - 2015-11-18 17:40:44,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 140300288 17:40:44 INFO - 2015-11-18 17:40:44,767 DEBUG : BROWSER_OUTPUT: 17:40:47 INFO - 2015-11-18 17:40:47,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50717/tests/kraken/driver.html?testName=audio-beat-detection) 17:40:47 INFO - 2015-11-18 17:40:47,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 180711424 17:40:47 INFO - 2015-11-18 17:40:47,811 DEBUG : BROWSER_OUTPUT: 17:40:50 INFO - 2015-11-18 17:40:50,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50717/tests/kraken/driver.html?testName=audio-dft) 17:40:50 INFO - 2015-11-18 17:40:50,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 169594880 17:40:50 INFO - 2015-11-18 17:40:50,986 DEBUG : BROWSER_OUTPUT: 17:40:53 INFO - 2015-11-18 17:40:53,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50717/tests/kraken/driver.html?testName=audio-fft) 17:40:54 INFO - 2015-11-18 17:40:54,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 152162304 17:40:54 INFO - 2015-11-18 17:40:54,393 DEBUG : BROWSER_OUTPUT: 17:40:56 INFO - 2015-11-18 17:40:56,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50717/tests/kraken/driver.html?testName=audio-oscillator) 17:40:56 INFO - 2015-11-18 17:40:56,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 154849280 17:40:56 INFO - 2015-11-18 17:40:56,959 DEBUG : BROWSER_OUTPUT: 17:40:59 INFO - 2015-11-18 17:40:59,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:40:59 INFO - 2015-11-18 17:40:59,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 155897856 17:40:59 INFO - 2015-11-18 17:40:59,706 DEBUG : BROWSER_OUTPUT: 17:41:02 INFO - 2015-11-18 17:41:02,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50717/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:03 INFO - 2015-11-18 17:41:03,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 155668480 17:41:03 INFO - 2015-11-18 17:41:03,208 DEBUG : BROWSER_OUTPUT: 17:41:06 INFO - 2015-11-18 17:41:06,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50717/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:07 INFO - 2015-11-18 17:41:07,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 158744576 17:41:07 INFO - 2015-11-18 17:41:07,177 DEBUG : BROWSER_OUTPUT: 17:41:09 INFO - 2015-11-18 17:41:09,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50717/tests/kraken/driver.html?testName=json-parse-financial) 17:41:10 INFO - 2015-11-18 17:41:10,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 155914240 17:41:10 INFO - 2015-11-18 17:41:10,491 DEBUG : BROWSER_OUTPUT: 17:41:12 INFO - 2015-11-18 17:41:12,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:41:12 INFO - 2015-11-18 17:41:12,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 167477248 17:41:12 INFO - 2015-11-18 17:41:12,626 DEBUG : BROWSER_OUTPUT: 17:41:14 INFO - 2015-11-18 17:41:14,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:41:15 INFO - 2015-11-18 17:41:15,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 167653376 17:41:15 INFO - 2015-11-18 17:41:15,022 DEBUG : BROWSER_OUTPUT: 17:41:17 INFO - 2015-11-18 17:41:17,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:41:17 INFO - 2015-11-18 17:41:17,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 174772224 17:41:17 INFO - 2015-11-18 17:41:17,648 DEBUG : BROWSER_OUTPUT: 17:41:20 INFO - 2015-11-18 17:41:20,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:41:20 INFO - 2015-11-18 17:41:20,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 180928512 17:41:20 INFO - 2015-11-18 17:41:20,668 DEBUG : BROWSER_OUTPUT: 17:41:23 INFO - 2015-11-18 17:41:23,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:41:23 INFO - 2015-11-18 17:41:23,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 178429952 17:41:23 INFO - 2015-11-18 17:41:23,808 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50717/tests/kraken/driver.html?testName=ai-astar) 17:41:25 INFO - 2015-11-18 17:41:25,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 237883392 17:41:25 INFO - 2015-11-18 17:41:25,735 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:41:25 INFO - 2015-11-18 17:41:25,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:41:25 INFO - 2015-11-18 17:41:25,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:41:25 INFO - 2015-11-18 17:41:25,739 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:41:25 INFO - 2015-11-18 17:41:25,739 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;107;113;111;112;119;112;112;110;110 17:41:25 INFO - 2015-11-18 17:41:25,739 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;124;150;165;127;147;156;123;178;124 17:41:25 INFO - 2015-11-18 17:41:25,739 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;161;162;161;160;162;161;163 17:41:25 INFO - 2015-11-18 17:41:25,739 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;83;103;71;73;71;96;90;71 17:41:25 INFO - 2015-11-18 17:41:25,739 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;149;91;91;92;136;90;91;135 17:41:25 INFO - 2015-11-18 17:41:25,740 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;110;109;111;109;110;109;109;110 17:41:25 INFO - 2015-11-18 17:41:25,740 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;146;145;145;145;144;145;144;144;145 17:41:25 INFO - 2015-11-18 17:41:25,740 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;97;96;96;96;97;95;96;96 17:41:25 INFO - 2015-11-18 17:41:25,740 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;58;58;58;58;59;67;56;56 17:41:25 INFO - 2015-11-18 17:41:25,740 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;70;70;69;69;74;69;70 17:41:25 INFO - 2015-11-18 17:41:25,741 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;83;85;85;85;86;85;86;86;86 17:41:25 INFO - 2015-11-18 17:41:25,741 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;118;120;133;123;125;134;121;122;118 17:41:25 INFO - 2015-11-18 17:41:25,741 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;147;160;148;152;139;154;152;150;139 17:41:25 INFO - 2015-11-18 17:41:25,741 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;66;69;69;67;69;71;69;68 17:41:25 INFO - 2015-11-18 17:41:25,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:41:25 INFO - 2015-11-18 17:41:25,742 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:41:25 INFO - 2015-11-18 17:41:25,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,950 17:41:25 INFO - 2015-11-18 17:41:25,742 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:41:25 INFO - 2015-11-18 17:41:25,742 DEBUG : BROWSER_OUTPUT: __startTimestamp1447897285736__endTimestamp 17:41:25 INFO - 2015-11-18 17:41:25,742 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:3.05 (2.7%) stddev-sans-first:3.23 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: Values: 112.0 107.0 113.0 111.0 112.0 119.0 112.0 112.0 110.0 110.0 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,746 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.00 stddev:19.37 (12.8%) stddev-sans-first:20.36 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: Values: 152.0 124.0 150.0 165.0 127.0 147.0 156.0 123.0 178.0 124.0 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 161.0 162.0 161.0 160.0 162.0 161.0 163.0 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:12.09 (16.6%) stddev-sans-first:12.36 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 83.0 103.0 71.0 73.0 71.0 96.0 90.0 71.0 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:91.00 stddev:24.03 (26.4%) stddev-sans-first:24.81 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 149.0 91.0 91.0 92.0 136.0 90.0 91.0 135.0 17:41:25 INFO - 2015-11-18 17:41:25,747 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 110.0 109.0 111.0 109.0 110.0 109.0 109.0 110.0 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.70 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: Values: 144.0 146.0 145.0 145.0 145.0 144.0 145.0 144.0 144.0 145.0 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 97.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.10 (5.3%) stddev-sans-first:3.28 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 58.0 58.0 58.0 58.0 59.0 67.0 56.0 56.0 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,748 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:1.49 (2.1%) stddev-sans-first:1.54 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 70.0 69.0 69.0 74.0 69.0 70.0 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:2.33 (2.7%) stddev-sans-first:0.97 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: Values: 92.0 83.0 85.0 85.0 85.0 86.0 85.0 86.0 86.0 86.0 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.50 stddev:5.61 (4.5%) stddev-sans-first:5.95 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: Values: 124.0 118.0 120.0 133.0 123.0 125.0 134.0 121.0 122.0 118.0 17:41:25 INFO - 2015-11-18 17:41:25,749 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:151.00 stddev:7.29 (4.8%) stddev-sans-first:6.80 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: Values: 138.0 147.0 160.0 148.0 152.0 139.0 154.0 152.0 150.0 139.0 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.50 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 66.0 69.0 69.0 67.0 69.0 71.0 69.0 68.0 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:41:25 INFO - 2015-11-18 17:41:25,750 DEBUG : BROWSER_OUTPUT: 17:41:26 INFO - 2015-11-18 17:41:26,574 INFO : Browser exited with error code: 0 17:41:26 INFO - 2015-11-18 17:41:26,625 INFO : Completed test kraken (00:00:58) 17:41:26 INFO - 2015-11-18 17:41:26,626 INFO : Starting test v8_7 17:41:26 INFO - 2015-11-18 17:41:26,626 DEBUG : operating with platform_type : linux_ 17:41:26 INFO - 2015-11-18 17:41:26,626 INFO : Initialising browser for v8_7 test... 17:41:26 INFO - 2015-11-18 17:41:26,632 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKpJUBp/profile http://localhost:50717/getInfo.html 17:41:30 INFO - 2015-11-18 17:41:30,431 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:41:30 INFO - 2015-11-18 17:41:30,431 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:41:30 INFO - 2015-11-18 17:41:30,431 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:41:30 INFO - 2015-11-18 17:41:30,431 DEBUG : BROWSER_OUTPUT: __metrics 17:41:30 INFO - 2015-11-18 17:41:30,588 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:41:31 INFO - 2015-11-18 17:41:31,638 INFO : Browser initialized. 17:41:31 INFO - 2015-11-18 17:41:31,639 INFO : Running cycle 1/1 for v8_7 test... 17:41:31 INFO - 2015-11-18 17:41:31,639 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKpJUBp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:41:43 INFO - 2015-11-18 17:41:43,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 140124160 17:41:43 INFO - 2015-11-18 17:41:43,491 DEBUG : BROWSER_OUTPUT: 17:42:04 INFO - 2015-11-18 17:42:04,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50717/tests/v8_7/run.html (next: http://localhost:50717/tests/v8_7/run.html) 17:42:05 INFO - 2015-11-18 17:42:05,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 624812032 17:42:05 INFO - 2015-11-18 17:42:05,224 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,224 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:42:05 INFO - 2015-11-18 17:42:05,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:42:05 INFO - 2015-11-18 17:42:05,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:42:05 INFO - 2015-11-18 17:42:05,225 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:42:05 INFO - 2015-11-18 17:42:05,225 DEBUG : BROWSER_OUTPUT: |0;Richards;163.18537859007833 17:42:05 INFO - 2015-11-18 17:42:05,225 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.29495718363464 17:42:05 INFO - 2015-11-18 17:42:05,225 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 17:42:05 INFO - 2015-11-18 17:42:05,225 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 17:42:05 INFO - 2015-11-18 17:42:05,225 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: |8;Splay;666.6666666666666 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: __startTimestamp1447897325221__endTimestamp 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:42:05 INFO - 2015-11-18 17:42:05,226 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.19 Median:163.19 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: Values: 163.2 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.29 Median:190.29 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: Values: 190.3 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,227 DEBUG : BROWSER_OUTPUT: Values: 280.9 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: Values: 5030.2 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: Values: 1980.2 17:42:05 INFO - 2015-11-18 17:42:05,228 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: Values: 780.6 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: Values: 12231.7 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: Values: 25450.0 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:666.67 Median:666.67 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: Values: 666.7 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:42:05 INFO - 2015-11-18 17:42:05,229 DEBUG : BROWSER_OUTPUT: 17:42:06 INFO - 2015-11-18 17:42:06,078 INFO : Browser exited with error code: 0 17:42:06 INFO - 2015-11-18 17:42:06,093 INFO : Completed test v8_7 (00:00:39) 17:42:06 INFO - 2015-11-18 17:42:06,145 INFO : Completed test suite (00:20:10) 17:42:06 INFO - 2015-11-18 17:42:06,145 DEBUG : Working with test: dromaeo_css 17:42:06 INFO - 2015-11-18 17:42:06,145 DEBUG : Generating results file: dromaeo_css 17:42:06 INFO - 2015-11-18 17:42:06,147 DEBUG : Working with test: kraken 17:42:06 INFO - 2015-11-18 17:42:06,147 DEBUG : Generating results file: kraken 17:42:06 INFO - 2015-11-18 17:42:06,147 INFO : javascript benchmark 17:42:06 INFO - 2015-11-18 17:42:06,147 DEBUG : Working with test: v8_7 17:42:06 INFO - 2015-11-18 17:42:06,148 DEBUG : Generating results file: v8_7 17:42:06 INFO - 2015-11-18 17:42:06,148 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:42:06 INFO - 2015-11-18 17:42:06,210 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:42:06 INFO - 2015-11-18 17:42:06,210 DEBUG : process_Request line: dromaeo_css 7067.59 graph.html#tests=[[72,64,35]] 17:42:06 INFO - 2015-11-18 17:42:06,210 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:42:06 INFO - 2015-11-18 17:42:06,243 DEBUG : process_Request line: kraken 1509.10 graph.html#tests=[[232,64,35]] 17:42:06 INFO - 2015-11-18 17:42:06,244 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:42:06 INFO - 2015-11-18 17:42:06,277 DEBUG : process_Request line: v8_7 19775.21 graph.html#tests=[[230,64,35]] 17:42:06 INFO - 2015-11-18 17:42:06,278 INFO : javascript benchmark 17:42:06 INFO - 2015-11-18 17:42:06,282 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3221.9355612887744, 3270.9018729438126, 3304.933901321975, 3308.305255896262, 3323.8670453181876, 5234.476552344764, 5328.1474964005765, 5419.214213938976, 5460.126379779231, 5482.314710661162, 5278.762455689493, 5330.3603567571945, 5338.412774594792, 5367.919481207775, 5498.3127109111365, 4896.9471563613815, 4903.583195428384, 4959.975200123994, 4992.67547609406, 5083.822066227683, 4863.489333619972, 4976.87557811054, 4985.775640096186, 5058.721770302632, 5076.340075790161, 4920.114379411704, 4981.750912454381, 4986.650934434591, 5022.974885125587, 5048.192289233742, 4959.628027897886, 4975.203967365241, 4983.401991760976, 5022.84931452057, 5024.472430394829, 4800.375951126366, 4902.3872015998, 4957.752112394366, 4978.054169707744, 5021.59827213822, 5209.557187639055, 5298.337707786527, 5316.255724198615, 5326.520613144797, 5328.653637513549, 5906.616069955439, 5935.317438494542, 5936.762529498815, 5949.018411962021, 5957.6127551709, 5741.540676745851, 5795.536357091422, 5969.940300596982, 5980.880382392328, 6000.309964354112, 5539.889202215933, 5548.611597188158, 5549.278593782782, 5552.972235138839, 5560.527355174815, 6034.426729460782, 6038.969805150946, 6052.152698622196, 6058.757649693963, 6059.0, 5617.494425501724, 5737.3688894221605, 5799.739011744482, 5843.29880414353, 5906.379830117861, 5921.141434491975, 5922.378150294243, 5929.407059294036, 5929.673867937305, 5935.376785437467, 5891.970540147272, 5898.085796701518, 5901.793437229677, 5906.143609176731, 5907.320658124285, 5699.572532060112, 5789.218455508452, 5828.970855145697, 5890.175375447441, 5931.199288096138, 4532.274836026286, 4534.433195850519, 4554.681172317973, 4570.8171673133365, 4619.907601848012, 4024.335984562573, 4027.335489644176, 4029.0330320722815, 4033.3546632538655, 4070.063885306337, 5425.538829199483, 5526.088195447706, 5533.7786488540005, 5567.498925096761, 5651.632643878134, 5860.472557469763, 5940.881182376328, 5945.227120474311, 5953.434423729739, 5957.731902064417, 5589.524890384281, 5594.832155035356, 5597.964376590262, 5598.524125449382, 5602.215689803431, 5028.622853286018, 5109.923351149736, 5148.510891465305, 5188.455212202664, 5235.502627250406, 6175.96912015437, 6194.34959329273, 6200.937990620036, 6205.348438413992, 6208.317085120633, 5690.687012214368, 5950.166976623363, 5977.551683623833, 5981.790637327673, 5983.730732116978, 5886.05823068307, 5911.940880591311, 5953.702314884152, 5995.820125396245, 6060.181875446759, 5824.708764561839, 5856.502197313276, 5864.853378665397, 5865.090910908816, 5873.559483038704, 5790.305163380252, 5929.407059294209, 5930.347661757117, 5951.107333899777, 5952.434518720715, 5669.064604340238, 5737.540996720169, 5751.654900705971, 5754.3382511010095, 5796.739146738491, 5722.7710891563875, 5732.16883551891, 5732.197492350991, 5735.254416925773, 5773.595848290747, 5459.044667183148, 5581.441855814386, 5589.077802162597, 5607.495325420732, 5622.0, 5777.2200752897825, 5860.501857342174, 5866.794662186803, 5880.441358070976, 5889.764409423575, 5656.490915817596, 5657.43425657431, 5663.745131469176, 5681.261436013458, 5681.573881958787], "unit": "ms", "name": "dojo.html", "value": 5423.665579432154}, {"lowerIsBetter": false, "replicates": [590.4449817171858, 595.1875689683582, 603.3875616249508, 608.2427377914495, 614.2230078950126, 32465.350692986125, 38365.23269534611, 38811.223775524544, 38816.223675526475, 38822.99999999996, 44058.77970610151, 44337.113257734825, 44385.11229775403, 44460.11079778402, 44830.32754508685, 7550.6979720811105, 7697.653605587734, 8666.696665616704, 8840.911590884074, 8844.778880528007, 10412.062914337708, 10733.141348692086, 10735.838962415532, 10737.946310268439, 10742.892571074306, 10412.791744165112, 10509.159267258601, 10529.15766738663, 10578.206634502405, 10582.365058096539, 7804.141544430108, 8023.197680231989, 10373.222008349328, 10425.635102771404, 10490.108340791005, 10335.173186145166, 10475.633352832614, 10488.68533943983, 10489.055984961391, 10492.632757853438, 39715.80142099271, 40125.197496049914, 40202.798986005175, 40212.39681404781, 40235.59764402348, 3381.120908563791, 3537.911552211215, 3772.0192749884955, 3902.863399780994, 4197.055662475918, 30268.394632107236, 30350.241243969078, 30727.231819204477, 31309.217269568442, 31539.21151971196, 3619.0952261934517, 3686.889393318205, 3687.3362794696945, 3726.739128261023, 3791.317562838688, 277279.0, 277632.0, 278994.0, 279100.0, 279544.0, 54292.45707542874, 55452.72273638606, 60667.0, 61212.693936530035, 66696.66651666808, 60865.69567152225, 60887.39112608906, 61125.69437152786, 61143.0, 61153.0, 14455.349509272108, 14543.3455494503, 14580.635484112981, 14600.561983140522, 14604.415823367159, 11208.439578021067, 11360.829587556193, 11398.031167350702, 11410.0, 11425.542978280942, 19957.700634490495, 20177.192912283637, 20242.805755395624, 20250.088746006466, 20259.797402026084, 7527.172011078777, 7716.382689384835, 7772.727954521564, 7773.106092799288, 7808.492447990862, 860.049645142109, 940.6378544260372, 977.9462129582942, 1029.6036026129993, 1043.3687618990552, 26565.734342656713, 27001.189964301102, 27048.59427108595, 28004.43991120166, 28365.71634283631, 986.3539381704994, 993.9105480506789, 1066.6320119558895, 1084.2301965604352, 1133.4049623947328, 14179.22014289224, 14181.432742690384, 14210.715785684228, 14393.64015899611, 14408.279586020657, 271515.0, 274115.0, 274789.0, 274880.0, 275876.0, 48224.27663585049, 48505.0, 48507.757461212466, 48532.27201591979, 48533.0, 1363.8840698540735, 1370.595674276091, 1372.499037851177, 1379.5102738527878, 1384.8753612174953, 27215.319617009733, 28123.57814632741, 28257.43485130327, 28258.15225543237, 29564.408711826072, 45124.32313515365, 46127.76936115432, 46315.0, 47098.76450617725, 50399.0, 227606.0, 228847.0, 229182.0, 230259.0, 230556.0, 29796.85101574565, 30419.39161216719, 30425.695743042284, 30441.695583044773, 30528.236794080327, 35263.64736352706, 41076.0, 44163.77918110389, 44621.77689111534, 45060.54939450695, 35486.46770298396, 35515.82242088773, 36999.445008325434, 37827.0, 37997.620023799405, 35020.0, 35188.296234075686, 35308.82345588256, 35342.82328588341, 35382.0, 34727.30545389027, 36591.0, 36599.26801464009, 36821.81589092038, 36839.079023023565, 28868.0, 30872.84563577168, 31266.53100203544, 31520.369592608477, 31597.368052639278, 24393.756062439857, 24404.75595244025, 24453.877730611945, 24536.141235056686, 24714.258572242863], "unit": "ms", "name": "ext.html", "value": 18505.714128952415}, {"lowerIsBetter": false, "replicates": [346.0138604975819, 348.783754072475, 352.1302383113708, 353.4909729988816, 356.54006331831937, 14775.187364694937, 14791.408343666268, 16778.41275555354, 17026.14869256537, 17766.911165444188, 15666.608334791636, 16253.18734063295, 16403.343866245337, 16921.576960575992, 16929.746053809173, 4703.670743047979, 5413.458654134594, 5414.8917021659545, 5415.810446634368, 5423.132298832187, 3974.4634474346026, 4079.1229885574594, 5369.543588794957, 5408.648437851547, 5768.971155144219, 5793.449622285876, 5860.882782344372, 5880.970595147019, 5881.470667639912, 5883.529317654577, 5528.806491772789, 5855.238818953551, 5898.882022359572, 5906.822795316148, 5912.290525137011, 5200.089984252779, 5221.921671174935, 5226.425093239741, 5228.55557277628, 5231.110711179071, 20174.0, 20642.27752028687, 20671.069801858954, 21025.369238922856, 21154.826775983573, 2142.2287976328507, 2172.4134483689472, 2199.82401407887, 2309.226409152936, 2565.371483986435, 13137.540186093536, 13399.0, 13530.526431574848, 13585.59243222695, 13663.316834158351, 1771.9911400443045, 1850.421765474633, 1857.7027675571844, 1858.3310008396966, 1879.7462342583713, 58801.41198588002, 59933.40066599322, 59965.0, 60055.0, 60956.0, 9486.90513094874, 9698.272629552812, 9890.258230632731, 9894.653687120915, 9933.850992235122, 12837.229766214057, 12841.0, 12860.742785144432, 12864.678383040498, 12876.871231287754, 7743.7676869694, 7751.302382785577, 7805.180456052033, 7805.453618246668, 7919.247671471201, 7658.61706914652, 7660.119086305035, 7741.7677469676, 7766.883496747553, 7790.143084260727, 5913.113033045078, 5990.251218597676, 6022.307434644984, 6047.879042419215, 6078.848028799315, 1624.3259047495394, 1673.1634182908547, 1682.8569571586308, 1685.7977042754703, 1734.2716059255142, 926.1892999186574, 936.578539657157, 961.2598299309493, 979.480875136179, 984.684900831727, 14991.700165996619, 16516.17419129039, 17056.147192640317, 17200.0, 17423.390181343846, 978.1245785022508, 979.6228452045871, 989.7674046599044, 1003.6738060130486, 1044.5404022230193, 10149.949250253701, 10191.7452063699, 10338.431386273676, 10419.426931518688, 10430.582776689, 510410.0, 518374.0, 518799.0, 521631.0, 529956.0, 70676.0, 73241.0, 73430.12558995267, 74076.0, 74713.0, 1151.8848115188582, 1158.8030034894089, 1161.4192903548226, 1168.1589255735857, 1169.7894379011689, 15491.612709681896, 15522.22388880574, 15590.22048897528, 15765.132917689638, 15966.600834978753, 30887.691123089382, 34963.951081467596, 35328.0, 36028.639713603574, 36552.45171322486, 38325.42511862268, 38363.616363836, 40644.39033414442, 40922.79538602288, 41033.384499233136, 6813.8637227254185, 6929.445644348541, 6971.825704357431, 6972.546784458994, 6980.267071957372, 10450.320729152885, 12362.690932726753, 12494.937525312314, 12748.171368861365, 12785.74428511406, 9274.072592740671, 10685.732856678645, 10770.246082774443, 10841.295315804447, 11037.227394082338, 10598.523066461874, 11031.22781405326, 11043.779124417628, 11064.114870810477, 11352.772944541228, 11009.61466348674, 11259.718507037389, 11353.943230283796, 11379.487923043649, 11464.94267528657, 6819.318068193141, 6941.34057264559, 6942.618156001468, 6942.791716248521, 6968.884978403431, 10658.253922225369, 10678.199135064746, 10700.518476668412, 10813.67558973232, 11216.046636035702], "unit": "ms", "name": "jquery.html", "value": 8513.854780896672}, {"lowerIsBetter": false, "replicates": [1329.7672907241242, 1445.4579532675248, 1478.1426772471964, 1618.9271482783274, 1767.6199617082325, 6692.063111164435, 7713.190115037924, 7846.960765196181, 7873.173316801739, 7895.131535531087, 7625.31372176504, 7739.226077392258, 7754.961225193881, 7758.030246219223, 7764.534127952327, 1978.465814230157, 2038.2764118737857, 2041.2855500574829, 2294.369048511656, 2333.57995560799, 2062.6802845558964, 2281.634938409855, 2329.2779238436055, 2330.2426711318803, 2331.755165707602, 2238.0488292475716, 2253.22263818983, 2259.9096036158535, 2302.96545551816, 2308.088305119485, 1997.6404247235491, 2040.9285675001304, 2298.6437102249092, 2324.244620498336, 2327.2669109230624, 2268.319504148765, 2316.397736588499, 2321.4776675247936, 2323.1288266899915, 2326.3137374474572, 7658.081030276402, 7821.2960833524685, 7834.138244793068, 7843.33331666809, 7852.136265010901, 4677.368555245032, 4764.213904705719, 4777.163996300634, 4789.544993225638, 4794.496577859344, 2992.8204307741607, 3142.937141257185, 3144.308252184516, 3166.509191075387, 3172.841357932094, 1060.8461773042943, 1120.383788916093, 1914.3682584747, 1967.3802752133033, 1991.9701204481944, 10771.299865508796, 10842.512086956027, 10865.782684346348, 10905.073068789163, 10932.344059356465, 4177.707560470799, 4248.87253382399, 4259.9574004260185, 4298.312270036779, 4322.438083049184, 8763.780905477413, 8841.823163536694, 8858.73423797287, 8883.600237989305, 8896.822063558693, 4725.653188841164, 4725.9527404726205, 4730.053989202173, 4733.692309999839, 4739.170645137087, 4383.167198232326, 4401.1417773534495, 4420.491643460979, 4433.467983841895, 4435.600795928382, 3439.2949445363643, 3506.9298614027575, 3541.451075083366, 3549.4853246279145, 3555.5733312002208, 1088.6733979806027, 1094.1192340166242, 1096.5997410944947, 1103.3269705479652, 1104.2160066352978, 1267.0813660096542, 1272.1031672670745, 1280.475005247844, 1299.2009913902882, 1305.0, 7476.626168691544, 7520.135184453858, 7537.585432801248, 7543.698252069966, 7553.471257012066, 506.010748985732, 508.12855952042423, 1189.851268591426, 1218.5004148299154, 1230.3479156047308, 5252.0, 5324.8136315228785, 5770.24986751728, 6071.241094863142, 6161.630302181883, 9188.173064424234, 9281.814363712689, 9405.529723513797, 9449.763755906157, 9451.858222126673, 9268.119528644767, 9273.443593384418, 9302.720918372459, 9398.624055037859, 9437.480938548308, 7204.675789589481, 7366.410687145016, 7410.221926697727, 7410.925890741131, 7456.32893039629, 7185.856282874209, 7217.278272172951, 7231.927680723125, 7234.855302893808, 7238.963805180941, 7961.522308661499, 8064.516129032277, 8211.548364839991, 8278.875816862632, 8298.502089874626, 8343.249107580346, 8414.663413463637, 8474.406791524534, 8562.657493700432, 8595.65617375298, 6910.585364878123, 6923.9653801730665, 6972.965135174291, 6993.125859267591, 7072.08062951813, 7526.285002924714, 7528.774136775905, 7563.7352692655495, 7581.696732130653, 7582.62086895642, 6940.340667636567, 7053.435725141873, 7062.258462861531, 7142.392896603639, 7174.713011479483, 6968.303169682991, 6977.825554361181, 7004.719811207495, 7062.329078737512, 7104.360607545345, 7031.332023457763, 7085.185203701434, 7136.0723105995885, 7150.892736609059, 7167.462440316893, 6538.084668146368, 6555.541112122106, 6581.769638062645, 6589.4728421725185, 6592.967035164986, 6430.871382572416, 6488.513361497812, 6550.737970481318, 6552.475801935929, 6555.901661475177], "unit": "ms", "name": "mootools.html", "value": 4528.147564167795}, {"lowerIsBetter": false, "replicates": [337.9425497665397, 340.65593750312183, 340.99147521311966, 341.93503234385463, 345.48005252095595, 5958.553108516868, 6099.390060993898, 6154.784582539612, 6166.167567378403, 6174.259088909332, 5908.822735317947, 6083.847903802407, 6093.207882975207, 6093.817185484431, 6095.116208149816, 4639.257718764999, 4676.602488788449, 4682.8126874924965, 4694.0611877624615, 4699.788509517063, 4473.776311184444, 4549.545045495441, 4566.246569316058, 4670.1126785910565, 4683.180443422404, 4575.473820510634, 4619.284010978304, 4622.468416132154, 4625.953740462603, 4634.258518637019, 4626.565764612981, 4630.143423466669, 4640.651951103664, 4644.326572646981, 4660.1145782301255, 4030.1133750574827, 4065.4308396824467, 4068.816903239361, 4080.326746086892, 4087.632113109805, 5665.206871038017, 5806.6225695330095, 5811.302643682743, 5836.533077353844, 5859.238299021143, 5467.234587157801, 5489.890202195934, 5494.752736126884, 5495.010898038351, 5505.724713764336, 6505.918106206016, 6516.0877477153235, 6521.184851893513, 6526.804195874131, 6527.02094685801, 4356.237658409797, 4563.452385713736, 4565.223911934946, 4565.292379681155, 4568.954310456887, 6771.390574848238, 6852.383285504278, 6853.280405557444, 6853.725850965955, 6861.176658800926, 4603.8618841434145, 4604.723716577016, 4605.746683932416, 4607.216773148572, 4611.0, 4651.1162879053545, 4660.627149828006, 4663.696859704109, 4663.766811659403, 4670.369500117441, 5300.628955973045, 5410.540104091197, 5417.187421886749, 5419.376771671229, 5425.457454254543, 6575.638339891256, 6585.209774827052, 6587.242467116247, 6588.901166482507, 6594.7032383542855, 1627.3409269245974, 1638.9344426222817, 1643.1784107946028, 1644.4244514419856, 1644.5888527868033, 1075.93544387337, 1081.853949716794, 1083.0469187115289, 1083.5286650306984, 1108.9500972456258, 6326.715297811609, 6332.018537126753, 6352.396522330371, 6359.046143078575, 6363.490920726331, 6538.967305163444, 6629.966850165718, 6645.903425934764, 6744.325567443315, 6804.897926531106, 6314.0, 6325.588836725598, 6326.652034138075, 6337.271213810471, 6411.685604451076, 3668.63313668631, 3698.3342998260573, 3700.555933287969, 3700.9259814803554, 3709.684676802502, 6913.170419549686, 7106.822329441805, 7110.537815042006, 7112.502124851314, 7130.42956563484, 7000.614966176808, 7008.299170082951, 7013.509054366145, 7014.438844892396, 7027.8594428111155, 7107.964460177769, 7110.431165506747, 7111.64441777909, 7118.25258347866, 7123.857522849617, 6653.933460665331, 6808.7276508939085, 6815.0, 6818.318168183142, 6828.487863410165, 6669.866602667822, 6713.496487763339, 6735.225449073223, 6754.763583274562, 6758.695858686273, 7103.857922841411, 7105.360517553445, 7113.75101871432, 7114.466415018791, 7116.608586527791, 4477.126960242721, 4561.042181141865, 4568.840090596813, 4572.839950601713, 4611.0, 6743.426808721314, 6776.186857577122, 6791.049253104668, 6791.117154769849, 6795.898061528982, 6584.670766461562, 6586.571872828251, 6587.901181482186, 6594.076829244005, 6601.570897891622, 6401.29585745577, 6590.308017658269, 6621.470282377302, 6642.036904648702, 6643.202815662152, 6495.382938620824, 6500.219973603198, 6510.381513756186, 6516.283208846929, 6527.05357723118, 6663.0, 6663.233728121134, 6671.499637527302, 6677.532572719863, 6677.69950352245, 6221.906671400023, 6284.937150628435, 6295.433410993032, 6479.125318082187, 6506.512011599054], "unit": "ms", "name": "prototype.html", "value": 4929.0017006859825}, {"lowerIsBetter": false, "replicates": [739.7447880481232, 783.3028604541959, 847.3052097280229, 884.8009197930464, 892.2460520859876, 13506.0, 13808.861911380884, 13882.722345553095, 14496.565103046925, 14529.273536323168, 14385.352659130338, 14494.710105797878, 14499.420023199085, 14504.202268875208, 14506.564803055899, 704.3590332797156, 711.5339452658517, 851.216880469966, 865.355310293832, 865.7792262972933, 845.8096928191138, 853.6030745703247, 859.6776208921623, 859.7893516088536, 860.8966923969133, 892.1970226795871, 899.5142622983581, 900.1088921967238, 901.5221932375819, 903.0969030969031, 732.0483371616904, 734.3024127079296, 864.6109250837148, 881.2421317666801, 898.9910100898973, 647.7311915555039, 651.1567520061532, 651.2250421997808, 651.2770824384929, 651.5243871973438, 12763.680907977281, 12841.486340546368, 12873.22760634365, 12877.742445151045, 12891.548795792196, 12426.689332766662, 12519.43662535188, 12796.680082997906, 12866.228026318451, 13518.188908665414, 10581.36511809294, 10779.892201078046, 10829.350238985686, 10941.507632156492, 11001.17491188164, 3532.6467353264725, 3713.0, 3729.160938788778, 3784.489093972306, 3880.06878349197, 44649.330260046125, 44859.32711009338, 44952.100957980656, 45093.77453112746, 45138.09723805539, 10342.844857327145, 10366.378017318984, 10427.426491543038, 10457.372557646566, 10691.946540267405, 19468.902655486632, 19619.509512262306, 19639.705404418946, 19647.31234406789, 19688.90155549213, 7917.524948503108, 7943.364530837519, 7971.681132754741, 8027.839443211103, 8039.276465118168, 4248.553901840324, 4302.827886884552, 4361.062371590124, 4372.23485889968, 4393.472783265965, 3246.0748686624197, 3253.024092772159, 3274.1323549259464, 3284.3595498877967, 3286.76992610515, 475.6028716022091, 493.2404097689518, 494.3079688436146, 500.5170010939461, 509.5846884788885, 602.0758136260819, 701.2216439751871, 731.0897932074495, 747.0922828763079, 749.5914726474085, 8607.311415086779, 8765.649374025095, 9160.038195989458, 9348.90651093494, 10065.276690387034, 708.2563308526027, 708.4686485136148, 710.9360157585738, 723.489939592586, 741.2032065529577, 4133.338665813455, 4211.241976444269, 4253.447051883235, 4258.68059895509, 4394.934075988863, 54303.0, 54966.725166374716, 61799.6910015456, 61836.0, 62028.069578956354, 51120.233196502086, 51861.48138518642, 52148.21777673338, 52377.2143417849, 52988.0, 48553.757231214324, 48821.75589122032, 48971.0, 49635.751821241385, 49961.25058124131, 9000.189982901571, 9043.0, 9306.813863722824, 9357.44670265424, 9410.43537387759, 36912.81543592265, 37015.25969480649, 37175.628243718296, 37397.439038413904, 38062.619373807014, 41840.071195016055, 47189.764051179525, 47322.29016564685, 47413.28880066733, 47832.0, 11932.70168245766, 11959.282443053444, 11971.221870578385, 11977.940110299392, 12489.687757806127, 12729.80905286403, 12857.807132893202, 12884.677883052998, 12945.935270323587, 12984.0, 11614.709632258922, 11693.473793679135, 12528.561500347445, 12579.937100314806, 12600.495980160691, 11770.882291176978, 12063.396830158632, 12081.879181208076, 12428.254304741744, 12457.314847683465, 10628.52171652262, 10812.67561973142, 10817.729556761144, 10893.183011274345, 11121.944390277997, 9953.153981911619, 9964.0, 10081.092701656886, 10086.092251697382, 10112.039356261143, 9318.487483188219, 9338.766530836783, 9514.952425237829, 9908.554115064695, 10059.69820905374], "unit": "ms", "name": "yui.html", "value": 6534.124723786185}], "name": "dromaeo_css", "value": 7067.590543775105}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 113.0, 111.0, 112.0, 119.0, 112.0, 112.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 150.0, 165.0, 127.0, 147.0, 156.0, 123.0, 178.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 83.0, 103.0, 71.0, 73.0, 71.0, 96.0, 90.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 149.0, 91.0, 91.0, 92.0, 136.0, 90.0, 91.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 109.0, 111.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [144.0, 146.0, 145.0, 145.0, 145.0, 144.0, 145.0, 144.0, 144.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.7}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 67.0, 56.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 74.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [92.0, 83.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [124.0, 118.0, 120.0, 133.0, 123.0, 125.0, 134.0, 121.0, 122.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 160.0, 148.0, 152.0, 139.0, 154.0, 152.0, 150.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 66.0, 69.0, 69.0, 67.0, 69.0, 71.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1509.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.18537859007833], "unit": "score", "name": "Richards", "value": 216.33065600000006}, {"lowerIsBetter": false, "replicates": [190.29495718363464], "unit": "score", "name": "DeltaBlue", "value": 347.4500900000001}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [666.6666666666666], "unit": "score", "name": "Splay", "value": 122.23650000000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19775.20591696094}]} 17:42:06 INFO - RETURN: dromaeo_css: 7067.59 17:42:06 INFO - RETURN: kraken: 1509.10 17:42:06 INFO - RETURN: v8_7: 19775.21 17:42:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19775.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7067.59"}}} 17:42:06 INFO - Return code: 0 17:42:06 INFO - # TBPL SUCCESS # 17:42:06 INFO - Running post-action listener: _resource_record_post_action 17:42:06 INFO - Running post-run listener: _resource_record_post_run 17:42:07 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 515645440; Read time: 140; Write time: 359456 17:42:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 139169792; Read time: 0; Write time: 100284 17:42:07 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 265822208; Read time: 20; Write time: 126496 17:42:07 INFO - Running post-run listener: _upload_blobber_files 17:42:07 INFO - Blob upload gear active. 17:42:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:42:07 INFO - Copying logs to upload dir... 17:42:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.611994 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-18 17:42:06.906645) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 17:42:06.912235) ========= 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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009965 build_url: 'https://queue.taskcluster.net/v1/task/M1PqMKa6S1ixNRsblALapw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 17:42:06.963990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:42:06.964323) ========= 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=5804b9f07a53938c557deee7000001c5-1447896070.888496-668799624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004809 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 17:42:07.015133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 17:42:07.015424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 17:42:07.015703) ========= ========= Total master_lag: 0.21 =========