builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1447944666.65 results: success (0) buildid: 20151119053001 builduid: b14e5f382b7f4597830e0ec69772a14c revision: 9a49075671cb62db97b9567a510a0bb361c9114a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.649137) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.649645) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.650004) ========= 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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005323 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.689601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.690006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.737340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.737634) ========= 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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023446 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.786963) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.787480) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.787912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:06.788213) ========= 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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 06:51:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-11-19 06:51:07 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:07.032206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:07.032570) ========= 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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.276865 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:07.321171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 06:51:07.321613) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9a49075671cb62db97b9567a510a0bb361c9114a --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 9a49075671cb62db97b9567a510a0bb361c9114a --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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 06:51:07,580 truncating revision to first 12 chars 2015-11-19 06:51:07,580 Setting DEBUG logging. 2015-11-19 06:51:07,580 attempt 1/10 2015-11-19 06:51:07,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9a49075671cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 06:51:08,693 unpacking tar archive at: fx-team-9a49075671cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 06:51:08.706887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:08.707213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:08.717362) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:08.717647) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:51:08.718175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 06:51:08.718503) ========= /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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:09 INFO - MultiFileLogger online at 20151119 06:51:09 in /builds/slave/test-pgo 06:51:09 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 06:51:09 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:51:09 INFO - {'append_to_log': False, 06:51:09 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:51:09 INFO - 'blob_upload_branch': 'Fx-Team', 06:51:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:51:09 INFO - 'branch': 'Fx-Team', 06:51:09 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:09 INFO - 'config_files': ('talos/linux_config.py',), 06:51:09 INFO - 'default_actions': ('clobber', 06:51:09 INFO - 'read-buildbot-config', 06:51:09 INFO - 'download-and-extract', 06:51:09 INFO - 'populate-webroot', 06:51:09 INFO - 'create-virtualenv', 06:51:09 INFO - 'install', 06:51:09 INFO - 'run-tests'), 06:51:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:09 INFO - 'download_minidump_stackwalk': True, 06:51:09 INFO - 'download_symbols': 'ondemand', 06:51:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:09 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:09 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:09 INFO - 'installer_path': 'installer.exe', 06:51:09 INFO - 'log_level': 'info', 06:51:09 INFO - 'log_name': 'talos', 06:51:09 INFO - 'log_to_console': True, 06:51:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:09 INFO - 'opt_config_files': (), 06:51:09 INFO - 'pip_index': False, 06:51:09 INFO - 'sps_profile': False, 06:51:09 INFO - 'sps_profile_interval': 0, 06:51:09 INFO - 'suite': 'dromaeojs', 06:51:09 INFO - 'system_bits': '64', 06:51:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:09 INFO - 'title': 'talos-linux64-ix-053', 06:51:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:09 INFO - 'use_talos_json': True, 06:51:09 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:51:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:09 INFO - 'work_dir': 'build'} 06:51:09 INFO - ##### 06:51:09 INFO - ##### Running clobber step. 06:51:09 INFO - ##### 06:51:09 INFO - Running pre-action listener: _resource_record_pre_action 06:51:09 INFO - Running main action method: clobber 06:51:09 INFO - rmtree: /builds/slave/test-pgo/build 06:51:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:51:14 INFO - Running post-action listener: _resource_record_post_action 06:51:14 INFO - ##### 06:51:14 INFO - ##### Running read-buildbot-config step. 06:51:14 INFO - ##### 06:51:14 INFO - Running pre-action listener: _resource_record_pre_action 06:51:14 INFO - Running main action method: read_buildbot_config 06:51:14 INFO - Using buildbot properties: 06:51:14 INFO - { 06:51:14 INFO - "properties": { 06:51:14 INFO - "buildnumber": 330, 06:51:14 INFO - "product": "firefox", 06:51:14 INFO - "script_repo_revision": "production", 06:51:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:51:14 INFO - "repository": "", 06:51:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:51:14 INFO - "buildid": "20151119053001", 06:51:14 INFO - "slavename": "talos-linux64-ix-053", 06:51:14 INFO - "pgo_build": "True", 06:51:14 INFO - "basedir": "/builds/slave/test-pgo", 06:51:14 INFO - "project": "", 06:51:14 INFO - "platform": "ubuntu64_hw", 06:51:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:14 INFO - "slavebuilddir": "test", 06:51:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:51:14 INFO - "branch": "fx-team", 06:51:14 INFO - "repo_path": "integration/fx-team", 06:51:14 INFO - "stage_platform": "linux64-pgo", 06:51:14 INFO - "builduid": "b14e5f382b7f4597830e0ec69772a14c", 06:51:14 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:51:14 INFO - }, 06:51:14 INFO - "sourcestamp": { 06:51:14 INFO - "repository": "", 06:51:14 INFO - "hasPatch": false, 06:51:14 INFO - "project": "", 06:51:14 INFO - "branch": "fx-team-linux64-pgo-talos", 06:51:14 INFO - "changes": [ 06:51:14 INFO - { 06:51:14 INFO - "category": null, 06:51:14 INFO - "files": [ 06:51:14 INFO - { 06:51:14 INFO - "url": null, 06:51:14 INFO - "name": "https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:51:14 INFO - } 06:51:14 INFO - ], 06:51:14 INFO - "repository": "", 06:51:14 INFO - "rev": "9a49075671cb62db97b9567a510a0bb361c9114a", 06:51:14 INFO - "who": "sendchange", 06:51:14 INFO - "when": 1447944630, 06:51:14 INFO - "number": 6682773, 06:51:14 INFO - "comments": "", 06:51:14 INFO - "project": "", 06:51:14 INFO - "at": "Thu 19 Nov 2015 06:50:30", 06:51:14 INFO - "branch": "fx-team-linux64-pgo-talos", 06:51:14 INFO - "revlink": "", 06:51:14 INFO - "properties": [ 06:51:14 INFO - [ 06:51:14 INFO - "buildid", 06:51:14 INFO - "20151119053001", 06:51:14 INFO - "Change" 06:51:14 INFO - ], 06:51:14 INFO - [ 06:51:14 INFO - "builduid", 06:51:14 INFO - "b14e5f382b7f4597830e0ec69772a14c", 06:51:14 INFO - "Change" 06:51:14 INFO - ], 06:51:14 INFO - [ 06:51:14 INFO - "pgo_build", 06:51:14 INFO - "True", 06:51:14 INFO - "Change" 06:51:14 INFO - ] 06:51:14 INFO - ], 06:51:14 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:51:14 INFO - } 06:51:14 INFO - ], 06:51:14 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:51:14 INFO - } 06:51:14 INFO - } 06:51:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:51:14 INFO - Running post-action listener: _resource_record_post_action 06:51:14 INFO - ##### 06:51:14 INFO - ##### Running download-and-extract step. 06:51:14 INFO - ##### 06:51:14 INFO - Running pre-action listener: _resource_record_pre_action 06:51:14 INFO - Running main action method: download_and_extract 06:51:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:51: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')]} 06:51:14 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:51:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json 06:51:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json 06:51:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:51:24 INFO - Downloaded 1302 bytes. 06:51:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:51:24 INFO - Using the following test package requirements: 06:51:24 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:24 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:24 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'jsshell-linux-x86_64.zip'], 06:51:24 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:24 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:24 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:51:24 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:51:24 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:24 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:24 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:24 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:24 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:24 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')]} 06:51:24 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:32 INFO - Downloaded 22474801 bytes. 06:51:32 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 06:51:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:32 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 06:51:33 INFO - Return code: 0 06:51:33 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 06:51: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')]} 06:51:33 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:40 INFO - Downloaded 22474801 bytes. 06:51:40 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 06:51:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:40 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 06:51:41 INFO - Return code: 0 06:51:41 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')]} 06:51:41 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:44 INFO - Downloaded 11130997 bytes. 06:51:44 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 06:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:44 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 06:51:44 INFO - Return code: 0 06:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:44 INFO - https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RLIVoSLkTIasmzBN54ZPNg/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 06:51:46 INFO - Downloaded 57204736 bytes. 06:51:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:46 INFO - mkdir: /builds/slave/test-pgo/properties 06:51:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:51:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:51:46 INFO - Contents: 06:51:46 INFO - build_url:https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:46 INFO - Running post-action listener: _resource_record_post_action 06:51:46 INFO - Running post-action listener: set_extra_try_arguments 06:51:46 INFO - ##### 06:51:46 INFO - ##### Running populate-webroot step. 06:51:46 INFO - ##### 06:51:46 INFO - Running pre-action listener: _resource_record_pre_action 06:51:46 INFO - Running main action method: populate_webroot 06:51:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:51:46 INFO - '../fennec_ids.txt'], 06:51:46 INFO - 'tests': ['tcheck2']}, 06:51:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:46 INFO - '--tppagecycles', 06:51:46 INFO - '7'], 06:51:46 INFO - 'tests': ['tsvgm']}}, 06:51:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:51:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'tests': ['damp', 'tps']}, 06:51:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['damp', 'tps']}, 06:51:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:51:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:46 INFO - 'other': {'tests': ['a11yr', 06:51:46 INFO - 'ts_paint', 06:51:46 INFO - 'tpaint', 06:51:46 INFO - 'sessionrestore', 06:51:46 INFO - 'sessionrestore_no_auto_restore']}, 06:51:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['a11yr', 06:51:46 INFO - 'ts_paint', 06:51:46 INFO - 'tpaint', 06:51:46 INFO - 'sessionrestore', 06:51:46 INFO - 'sessionrestore_no_auto_restore']}, 06:51:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['a11yr', 06:51:46 INFO - 'ts_paint', 06:51:46 INFO - 'tpaint', 06:51:46 INFO - 'sessionrestore', 06:51:46 INFO - 'sessionrestore_no_auto_restore']}, 06:51:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['a11yr', 06:51:46 INFO - 'ts_paint', 06:51:46 INFO - 'tpaint', 06:51:46 INFO - 'sessionrestore', 06:51:46 INFO - 'sessionrestore_no_auto_restore']}, 06:51:46 INFO - 'other_l64': {'tests': ['a11yr', 06:51:46 INFO - 'ts_paint', 06:51:46 INFO - 'tpaint', 06:51:46 INFO - 'sessionrestore', 06:51:46 INFO - 'sessionrestore_no_auto_restore']}, 06:51:46 INFO - 'other_nol64': {'tests': ['a11yr', 06:51:46 INFO - 'ts_paint', 06:51:46 INFO - 'tpaint', 06:51:46 INFO - 'sessionrestore', 06:51:46 INFO - 'sessionrestore_no_auto_restore']}, 06:51:46 INFO - 'svgr': {'tests': ['tsvgx', 06:51:46 INFO - 'tsvgr_opacity', 06:51:46 INFO - 'tart', 06:51:46 INFO - 'tscrollx', 06:51:46 INFO - 'cart']}, 06:51:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['tsvgx', 06:51:46 INFO - 'tsvgr_opacity', 06:51:46 INFO - 'tart', 06:51:46 INFO - 'tscrollx', 06:51:46 INFO - 'cart']}, 06:51:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'tests': ['tp5o']}, 06:51:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'talos_options': ['--e10s'], 06:51:46 INFO - 'tests': ['tp5o']}, 06:51:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'talos_options': ['--xperf_path', 06:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:46 INFO - 'tests': ['tp5n']}, 06:51:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:46 INFO - 'talos_options': ['--e10s', 06:51:46 INFO - '--xperf_path', 06:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:46 INFO - 'tests': ['tp5n']}}, 06:51:46 INFO - 'talos.zip': {'path': '', 06:51:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:46 INFO - Running post-action listener: _resource_record_post_action 06:51:46 INFO - ##### 06:51:46 INFO - ##### Running create-virtualenv step. 06:51:46 INFO - ##### 06:51:46 INFO - Running pre-action listener: _resource_record_pre_action 06:51:46 INFO - Running main action method: create_virtualenv 06:51:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:51:46 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 06:51:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:51:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:46 INFO - Using real prefix '/usr' 06:51:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:51:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:49 INFO - Installing pip.................done. 06:51:49 INFO - Return code: 0 06:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:51:49 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')]} 06:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:49 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')]} 06:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:49 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 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:51:49 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 06:51:49 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 06:51:49 INFO - Using env: {'DISPLAY': ':0', 06:51:49 INFO - 'HOME': '/home/cltbld', 06:51:49 INFO - 'LANG': 'en_US.UTF-8', 06:51:49 INFO - 'LANGUAGE': 'en_US:en', 06:51:49 INFO - 'LOGNAME': 'cltbld', 06:51:49 INFO - 'MAIL': '/var/mail/cltbld', 06:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:49 INFO - 'MOZ_NO_REMOTE': '1', 06:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:49 INFO - 'NO_EM_RESTART': '1', 06:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:49 INFO - 'SHELL': '/bin/bash', 06:51:49 INFO - 'SHLVL': '1', 06:51:49 INFO - 'TERM': 'linux', 06:51:49 INFO - 'TMOUT': '86400', 06:51:49 INFO - 'USER': 'cltbld', 06:51:49 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:49 INFO - '_': '/tools/buildbot/bin/python'} 06:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:49 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 06:51:49 INFO - Cleaning up... 06:51:49 INFO - Return code: 0 06:51:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:51:49 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')]} 06:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:49 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')]} 06:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:49 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 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:51:49 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 06:51:49 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 06:51:49 INFO - Using env: {'DISPLAY': ':0', 06:51:49 INFO - 'HOME': '/home/cltbld', 06:51:49 INFO - 'LANG': 'en_US.UTF-8', 06:51:49 INFO - 'LANGUAGE': 'en_US:en', 06:51:49 INFO - 'LOGNAME': 'cltbld', 06:51:49 INFO - 'MAIL': '/var/mail/cltbld', 06:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:49 INFO - 'MOZ_NO_REMOTE': '1', 06:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:49 INFO - 'NO_EM_RESTART': '1', 06:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:49 INFO - 'SHELL': '/bin/bash', 06:51:49 INFO - 'SHLVL': '1', 06:51:49 INFO - 'TERM': 'linux', 06:51:49 INFO - 'TMOUT': '86400', 06:51:49 INFO - 'USER': 'cltbld', 06:51:49 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:49 INFO - '_': '/tools/buildbot/bin/python'} 06:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:50 INFO - Downloading/unpacking psutil>=0.7.1 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:51:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:51:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:51 INFO - Installing collected packages: psutil 06:51:51 INFO - Running setup.py install for psutil 06:51:51 INFO - building 'psutil._psutil_linux' extension 06:51:51 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 06:51:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:51:52 INFO - building 'psutil._psutil_posix' extension 06:51:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:51:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:53 INFO - Successfully installed psutil 06:51:53 INFO - Cleaning up... 06:51:53 INFO - Return code: 0 06:51:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:51:53 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')]} 06:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:53 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')]} 06:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:53 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 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:51:53 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 06:51:53 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 06:51:53 INFO - Using env: {'DISPLAY': ':0', 06:51:53 INFO - 'HOME': '/home/cltbld', 06:51:53 INFO - 'LANG': 'en_US.UTF-8', 06:51:53 INFO - 'LANGUAGE': 'en_US:en', 06:51:53 INFO - 'LOGNAME': 'cltbld', 06:51:53 INFO - 'MAIL': '/var/mail/cltbld', 06:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:53 INFO - 'MOZ_NO_REMOTE': '1', 06:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:53 INFO - 'NO_EM_RESTART': '1', 06:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:53 INFO - 'SHELL': '/bin/bash', 06:51:53 INFO - 'SHLVL': '1', 06:51:53 INFO - 'TERM': 'linux', 06:51:53 INFO - 'TMOUT': '86400', 06:51:53 INFO - 'USER': 'cltbld', 06:51:53 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:53 INFO - '_': '/tools/buildbot/bin/python'} 06:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:51:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:55 INFO - Installing collected packages: mozsystemmonitor 06:51:55 INFO - Running setup.py install for mozsystemmonitor 06:51:55 INFO - Successfully installed mozsystemmonitor 06:51:55 INFO - Cleaning up... 06:51:55 INFO - Return code: 0 06:51:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 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 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:51:55 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 06:51:55 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 06:51:55 INFO - Using env: {'DISPLAY': ':0', 06:51:55 INFO - 'HOME': '/home/cltbld', 06:51:55 INFO - 'LANG': 'en_US.UTF-8', 06:51:55 INFO - 'LANGUAGE': 'en_US:en', 06:51:55 INFO - 'LOGNAME': 'cltbld', 06:51:55 INFO - 'MAIL': '/var/mail/cltbld', 06:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:55 INFO - 'MOZ_NO_REMOTE': '1', 06:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:55 INFO - 'NO_EM_RESTART': '1', 06:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:55 INFO - 'SHELL': '/bin/bash', 06:51:55 INFO - 'SHLVL': '1', 06:51:55 INFO - 'TERM': 'linux', 06:51:55 INFO - 'TMOUT': '86400', 06:51:55 INFO - 'USER': 'cltbld', 06:51:55 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:55 INFO - '_': '/tools/buildbot/bin/python'} 06:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:51:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:57 INFO - Downloading docopt-0.6.1.tar.gz 06:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:57 INFO - Running setup.py install for blobuploader 06:51:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:51:57 INFO - Running setup.py install for requests 06:51:58 INFO - Running setup.py install for docopt 06:51:58 INFO - Successfully installed blobuploader requests docopt 06:51:58 INFO - Cleaning up... 06:51:58 INFO - Return code: 0 06:51:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:58 INFO - Using env: {'DISPLAY': ':0', 06:51:58 INFO - 'HOME': '/home/cltbld', 06:51:58 INFO - 'LANG': 'en_US.UTF-8', 06:51:58 INFO - 'LANGUAGE': 'en_US:en', 06:51:58 INFO - 'LOGNAME': 'cltbld', 06:51:58 INFO - 'MAIL': '/var/mail/cltbld', 06:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:58 INFO - 'MOZ_NO_REMOTE': '1', 06:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:58 INFO - 'NO_EM_RESTART': '1', 06:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:58 INFO - 'SHELL': '/bin/bash', 06:51:58 INFO - 'SHLVL': '1', 06:51:58 INFO - 'TERM': 'linux', 06:51:58 INFO - 'TMOUT': '86400', 06:51:58 INFO - 'USER': 'cltbld', 06:51:58 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:58 INFO - '_': '/tools/buildbot/bin/python'} 06:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:58 INFO - Running setup.py (path:/tmp/pip-9jBaaz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:58 INFO - Running setup.py (path:/tmp/pip-2tKvYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:58 INFO - Running setup.py (path:/tmp/pip-Zjklc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:58 INFO - Running setup.py (path:/tmp/pip-h85Lyz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:58 INFO - Running setup.py (path:/tmp/pip-vT8eLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:58 INFO - Running setup.py (path:/tmp/pip-rr31Qj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:59 INFO - Running setup.py (path:/tmp/pip-eV_0C3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:59 INFO - Running setup.py (path:/tmp/pip-muWmzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:59 INFO - Running setup.py (path:/tmp/pip-PrMkhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:59 INFO - Running setup.py (path:/tmp/pip-v_h2KT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:59 INFO - Running setup.py (path:/tmp/pip-49VQR2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:59 INFO - Running setup.py (path:/tmp/pip-J_QuRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:59 INFO - Running setup.py (path:/tmp/pip-Pn2R52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:59 INFO - Running setup.py (path:/tmp/pip-Zj2avs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:59 INFO - Running setup.py (path:/tmp/pip-3uE28n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:59 INFO - Running setup.py (path:/tmp/pip-qxFSnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:59 INFO - Running setup.py (path:/tmp/pip-2oCwQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:59 INFO - Running setup.py install for manifestparser 06:51:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:51:59 INFO - Running setup.py install for mozcrash 06:51:59 INFO - Running setup.py install for mozdebug 06:52:00 INFO - Running setup.py install for mozdevice 06:52:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Running setup.py install for mozfile 06:52:00 INFO - Running setup.py install for mozhttpd 06:52:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Running setup.py install for mozinfo 06:52:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Running setup.py install for mozInstall 06:52:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Running setup.py install for mozleak 06:52:00 INFO - Running setup.py install for mozlog 06:52:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Running setup.py install for moznetwork 06:52:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:52:00 INFO - Running setup.py install for mozprocess 06:52:00 INFO - Running setup.py install for mozprofile 06:52:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:52:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:52:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:52:01 INFO - Running setup.py install for mozrunner 06:52:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:52:01 INFO - Running setup.py install for mozscreenshot 06:52:01 INFO - Running setup.py install for moztest 06:52:01 INFO - Running setup.py install for mozversion 06:52:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:52:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:01 INFO - Cleaning up... 06:52:01 INFO - Return code: 0 06:52:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:52:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:52:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:52:01 INFO - Using env: {'DISPLAY': ':0', 06:52:01 INFO - 'HOME': '/home/cltbld', 06:52:01 INFO - 'LANG': 'en_US.UTF-8', 06:52:01 INFO - 'LANGUAGE': 'en_US:en', 06:52:01 INFO - 'LOGNAME': 'cltbld', 06:52:01 INFO - 'MAIL': '/var/mail/cltbld', 06:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:01 INFO - 'MOZ_NO_REMOTE': '1', 06:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:01 INFO - 'NO_EM_RESTART': '1', 06:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:01 INFO - 'SHELL': '/bin/bash', 06:52:01 INFO - 'SHLVL': '1', 06:52:01 INFO - 'TERM': 'linux', 06:52:01 INFO - 'TMOUT': '86400', 06:52:01 INFO - 'USER': 'cltbld', 06:52:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:01 INFO - '_': '/tools/buildbot/bin/python'} 06:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:01 INFO - Running setup.py (path:/tmp/pip-mukQp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:01 INFO - Running setup.py (path:/tmp/pip-iOG8_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:01 INFO - Running setup.py (path:/tmp/pip-WAoiuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:01 INFO - Running setup.py (path:/tmp/pip-mjZkQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:02 INFO - Running setup.py (path:/tmp/pip-SHNDem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:02 INFO - Running setup.py (path:/tmp/pip-GwOX_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:02 INFO - Running setup.py (path:/tmp/pip-LhjI3d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:02 INFO - Running setup.py (path:/tmp/pip-t8nBKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:02 INFO - Running setup.py (path:/tmp/pip-c1QEPo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:02 INFO - Running setup.py (path:/tmp/pip-cznWJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:02 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)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:02 INFO - Running setup.py (path:/tmp/pip-o0Uxgs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:02 INFO - Running setup.py (path:/tmp/pip-cGFjff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:02 INFO - Running setup.py (path:/tmp/pip-A95kBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:02 INFO - Running setup.py (path:/tmp/pip-HfHJay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:02 INFO - Running setup.py (path:/tmp/pip-XaeSjQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:02 INFO - Running setup.py (path:/tmp/pip-6jetFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:02 INFO - Running setup.py (path:/tmp/pip-Zwp5vD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 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)) 06:52:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:03 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 06:52:03 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 06:52:03 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 06:52:03 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 06:52:03 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 06:52:03 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 06:52:04 INFO - Downloading blessings-1.5.1.tar.gz 06:52:04 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:52:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:04 INFO - Installing collected packages: blessings 06:52:04 INFO - Running setup.py install for blessings 06:52:04 INFO - Successfully installed blessings 06:52:04 INFO - Cleaning up... 06:52:04 INFO - Return code: 0 06:52:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:52:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:05 INFO - Reading from file tmpfile_stdout 06:52:05 INFO - Current package versions: 06:52:05 INFO - argparse == 1.2.1 06:52:05 INFO - blessings == 1.5.1 06:52:05 INFO - blobuploader == 1.2.4 06:52:05 INFO - docopt == 0.6.1 06:52:05 INFO - manifestparser == 1.1 06:52:05 INFO - mozInstall == 1.12 06:52:05 INFO - mozcrash == 0.16 06:52:05 INFO - mozdebug == 0.1 06:52:05 INFO - mozdevice == 0.47 06:52:05 INFO - mozfile == 1.2 06:52:05 INFO - mozhttpd == 0.7 06:52:05 INFO - mozinfo == 0.9 06:52:05 INFO - mozleak == 0.1 06:52:05 INFO - mozlog == 3.0 06:52:05 INFO - moznetwork == 0.27 06:52:05 INFO - mozprocess == 0.22 06:52:05 INFO - mozprofile == 0.27 06:52:05 INFO - mozrunner == 6.11 06:52:05 INFO - mozscreenshot == 0.1 06:52:05 INFO - mozsystemmonitor == 0.0 06:52:05 INFO - moztest == 0.7 06:52:05 INFO - mozversion == 1.4 06:52:05 INFO - psutil == 3.1.1 06:52:05 INFO - requests == 1.2.3 06:52:05 INFO - wsgiref == 0.1.2 06:52:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:05 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 0x7f844e889c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, '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': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', '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 06:52:05 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 06:52:05 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 06:52:05 INFO - Using env: {'DISPLAY': ':0', 06:52:05 INFO - 'HOME': '/home/cltbld', 06:52:05 INFO - 'LANG': 'en_US.UTF-8', 06:52:05 INFO - 'LANGUAGE': 'en_US:en', 06:52:05 INFO - 'LOGNAME': 'cltbld', 06:52:05 INFO - 'MAIL': '/var/mail/cltbld', 06:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:05 INFO - 'MOZ_NO_REMOTE': '1', 06:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:05 INFO - 'NO_EM_RESTART': '1', 06:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:05 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:05 INFO - 'SHELL': '/bin/bash', 06:52:05 INFO - 'SHLVL': '1', 06:52:05 INFO - 'TERM': 'linux', 06:52:05 INFO - 'TMOUT': '86400', 06:52:05 INFO - 'USER': 'cltbld', 06:52:05 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:05 INFO - '_': '/tools/buildbot/bin/python'} 06:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:52:05 INFO - Cleaning up... 06:52:05 INFO - Return code: 0 06:52:05 INFO - Running post-action listener: _resource_record_post_action 06:52:05 INFO - Running post-action listener: _start_resource_monitoring 06:52:05 INFO - Starting resource monitoring. 06:52:05 INFO - ##### 06:52:05 INFO - ##### Running install step. 06:52:05 INFO - ##### 06:52:05 INFO - Running pre-action listener: _resource_record_pre_action 06:52:05 INFO - Running main action method: install 06:52:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:05 INFO - Reading from file tmpfile_stdout 06:52:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:52:05 INFO - Reading from file tmpfile_stdout 06:52:05 INFO - Output received: 06:52:05 INFO - Usage: mozinstall [options] installer 06:52:05 INFO - Options: 06:52:05 INFO - -h, --help show this help message and exit 06:52:05 INFO - -d DEST, --destination=DEST 06:52:05 INFO - Directory to install application into. [default: 06:52:05 INFO - "/builds/slave/test-pgo"] 06:52:05 INFO - --app=APP Application being installed. [default: firefox] 06:52:05 INFO - mkdir: /builds/slave/test-pgo/build/application 06:52:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:52:20 INFO - Reading from file tmpfile_stdout 06:52:20 INFO - Output received: 06:52:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:52:20 INFO - Running post-action listener: _resource_record_post_action 06:52:20 INFO - ##### 06:52:20 INFO - ##### Running run-tests step. 06:52:20 INFO - ##### 06:52:20 INFO - Running pre-action listener: _resource_record_pre_action 06:52:20 INFO - Running main action method: run_tests 06:52:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:52:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:52:20 INFO - Python 2.7.3 06:52:20 INFO - Return code: 0 06:52:20 INFO - grabbing minidump binary from tooltool 06:52: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')]} 06:52:20 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 0x2923d70>, '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 0x2924b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:52:20 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 06:52:20 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 06:52:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:20 INFO - Return code: 0 06:52:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:52:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:52:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:52:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:20 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/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:52:20 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/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 06:52:20 INFO - Using env: {'DISPLAY': ':0', 06:52:20 INFO - 'HOME': '/home/cltbld', 06:52:20 INFO - 'LANG': 'en_US.UTF-8', 06:52:20 INFO - 'LANGUAGE': 'en_US:en', 06:52:20 INFO - 'LOGNAME': 'cltbld', 06:52:20 INFO - 'MAIL': '/var/mail/cltbld', 06:52:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:20 INFO - 'MOZ_NO_REMOTE': '1', 06:52:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:20 INFO - 'NO_EM_RESTART': '1', 06:52:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:20 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:52:20 INFO - 'SHELL': '/bin/bash', 06:52:20 INFO - 'SHLVL': '1', 06:52:20 INFO - 'TERM': 'linux', 06:52:20 INFO - 'TMOUT': '86400', 06:52:20 INFO - 'USER': 'cltbld', 06:52:20 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073', 06:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:20 INFO - '_': '/tools/buildbot/bin/python'} 06:52:20 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/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 06:52:20 INFO - mozversion INFO | application_buildid: 20151119053001 06:52:20 INFO - mozversion INFO | application_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:52:20 INFO - mozversion INFO | application_display_name: Nightly 06:52:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:20 INFO - mozversion INFO | application_name: Firefox 06:52:20 INFO - mozversion INFO | application_remotingname: firefox 06:52:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:52:20 INFO - mozversion INFO | application_vendor: Mozilla 06:52:20 INFO - mozversion INFO | application_version: 45.0a1 06:52:20 INFO - mozversion INFO | platform_buildid: 20151119053001 06:52:20 INFO - mozversion INFO | platform_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:52:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:52:20 INFO - mozversion INFO | platform_version: 45.0a1 06:52:20 INFO - 2015-11-19 06:52:20,401 DEBUG : using testdate: 1447944740 06:52:20 INFO - 2015-11-19 06:52:20,401 DEBUG : actual date: 1447944740 06:52:20 INFO - 2015-11-19 06:52:20,451 INFO : starting webserver on 'localhost:56446' 06:52:20 INFO - 2015-11-19 06:52:20,452 INFO : Starting test suite talos-linux64-ix-053 06:52:20 INFO - 2015-11-19 06:52:20,452 INFO : Starting test dromaeo_css 06:52:20 INFO - 2015-11-19 06:52:20,452 DEBUG : operating with platform_type : linux_ 06:52:20 INFO - 2015-11-19 06:52:20,453 INFO : Initialising browser for dromaeo_css test... 06:52:20 INFO - 2015-11-19 06:52:20,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbt3Buo/profile http://localhost:56446/getInfo.html 06:52:26 INFO - 2015-11-19 06:52:26,532 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:52:26 INFO - 2015-11-19 06:52:26,532 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:52:26 INFO - 2015-11-19 06:52:26,532 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:52:26 INFO - 2015-11-19 06:52:26,532 DEBUG : BROWSER_OUTPUT: __metrics 06:52:26 INFO - 2015-11-19 06:52:26,669 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:52:27 INFO - 2015-11-19 06:52:27,842 INFO : Browser initialized. 06:52:27 INFO - 2015-11-19 06:52:27,843 INFO : Running cycle 1/1 for dromaeo_css test... 06:52:27 INFO - 2015-11-19 06:52:27,843 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbt3Buo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:52:39 INFO - 2015-11-19 06:52:39,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 139948032 06:52:39 INFO - 2015-11-19 06:52:39,635 DEBUG : BROWSER_OUTPUT: 06:53:30 INFO - 2015-11-19 06:53:30,288 DEBUG : BROWSER_OUTPUT: 1447944810287 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] 06:55:40 INFO - 2015-11-19 06:55:40,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56446/tests/dromaeo/cssquery-ext.html) 06:55:41 INFO - 2015-11-19 06:55:41,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 223182848 06:55:41 INFO - 2015-11-19 06:55:41,217 DEBUG : BROWSER_OUTPUT: 06:58:43 INFO - 2015-11-19 06:58:43,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-ext.html (next: http://localhost:56446/tests/dromaeo/cssquery-jquery.html) 06:58:44 INFO - 2015-11-19 06:58:44,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 224497664 06:58:44 INFO - 2015-11-19 06:58:44,156 DEBUG : BROWSER_OUTPUT: 07:01:46 INFO - 2015-11-19 07:01:46,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56446/tests/dromaeo/cssquery-mootools.html) 07:01:46 INFO - 2015-11-19 07:01:46,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 212951040 07:01:46 INFO - 2015-11-19 07:01:46,667 DEBUG : BROWSER_OUTPUT: 07:04:48 INFO - 2015-11-19 07:04:48,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56446/tests/dromaeo/cssquery-prototype.html) 07:04:49 INFO - 2015-11-19 07:04:49,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 205283328 07:04:49 INFO - 2015-11-19 07:04:49,059 DEBUG : BROWSER_OUTPUT: 07:07:51 INFO - 2015-11-19 07:07:51,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56446/tests/dromaeo/cssquery-yui.html) 07:07:52 INFO - 2015-11-19 07:07:52,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 201842688 07:07:52 INFO - 2015-11-19 07:07:52,040 DEBUG : BROWSER_OUTPUT: 07:10:54 INFO - 2015-11-19 07:10:54,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-yui.html (next: http://localhost:56446/tests/dromaeo/cssquery-dojo.html) 07:10:54 INFO - 2015-11-19 07:10:54,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 244707328 07:10:54 INFO - 2015-11-19 07:10:54,986 DEBUG : BROWSER_OUTPUT: 07:10:54 INFO - 2015-11-19 07:10:54,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:54 INFO - 2015-11-19 07:10:54,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:54 INFO - 2015-11-19 07:10:54,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:54 INFO - 2015-11-19 07:10:54,988 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:54 INFO - 2015-11-19 07:10:54,992 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3228.8062716237027;3283.6716328367165;3320.3027364253508;3330.9500357494626;3334.649861764514;5204.687718736869;5290.206469029647;5426.321709786277;5427;5458.7270636468165;5373.838784836461;5398.4601539846;5470.72646367681;5478.561715062795;5493.972530137354;4913.950860491403;4950.925736113961;5087.643864929457;5092.414372347172;5123.333966584339;4848;5049.2173713074535;5083.974580127094;5097.643164978453;5122.436531981498;4899.755012249373;4964.67729597575;4974.3533340665845;5001.474845141281;5022.045811295842;4969.776360063805;4970.130227210224;4978.079055374767;4999.575036121934;5027.899442011139;4814.277858321245;4949.653524253267;4969.27945447908;4979.3526841510375;5014.59883209346;5192.247124167013;5324.920126198072;5325.360956685184;5325.946740532622;5361.276227709248;5918.8816223675285;5924.289085309747;5924.7333869975955;5932.2584676915385;5939.67331796751;5864.5894787364905;5870.442307980735;5947.494462970652;5951.9107213391835;5999.520038396961;5503.9174412383845;5513.283273174542;5513.807016754395;5521.061419558685;5550.4449555044575;5971.014782560829;6002.4897883679505;6019.729112189962;6020.4280593343565;6021.668808215591;5644.576656750678;5754.5971781975695;5795.536357091422;5859.296884373903;5915.763369465173;5928.318243402064;5946.375630558816;5948.940510594839;5951.613145145551;5955.28536575605;5919.260092488439;5938.406159384113;5945.762169513171;5946.8810623787285;5948.67282299469;5728.341240757283;5783.884322313615;5878.353381128158;5878.382769809194;5921.970390148022;4522.389477420572;4539.72761634303;4548.976480291908;4571.291449825282;4587.472440669299;4021.939670904939;4027.91944161121;4034.616711412411;4045.110075783323;4073.490813648294;5395.892082158335;5489.149181876815;5502.614816962854;5578.44215578447;5595.552355811526;5803.564732645069;5809;5813.738381772746;5857.970710146422;5946.970265148647;5519.751611177507;5521.116621340566;5521.668699878021;5524.530414914777;5532.197831314517;4991.07665081961;5071.949280507221;5107.33604631403;5120.078385890501;5181;6106.908396374147;6110.938890611037;6114;6120.44915957566;6132.356102609251;5907.468327850343;5913.172155898092;5919.052951527735;5925.348211696796;5925.881482370242;5834.562407819515;5950.19672344228;5965;5966.164736936919;6092.786752463642;5790.652560846363;5853.239078919713;5854.94145058561;5859.384764599656;5863.560232982629;5915.822525324247;5923.259592550931;5931.110333450017;5938.8218353449465;5940.376260492586;5539.667619942817;5653.038983372754;5693.629914055573;5699;5775.509081727932;5689;5698.430156984434;5742.569307302053;5742.7702891883855;5746.224259725051;5650.29371328584;5655;5665.858353541194;5666.206731057738;5669.659820410789;5624.381318055092;5657.462541058593;5743;5783.537317014545;5788.942110578841;5627.493525582717;5676.914846277226;5682.176084467812;5687.687177205294;5691.345495267931 07:10:54 INFO - 2015-11-19 07:10:54,993 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.6170758153409;585.2947198625657;586.6626689653448;587.3656451032884;590.8493334199778;31641;39729.80135099328;40352;40445;40458.393124103124;43145.7842710786;43681;43688.3446748299;43767;43799.56200437995;7647.617619119022;7788.844223115534;8683.696070637528;8794.384393092487;8809.603567839431;10497;10805.351678899251;10817;10817.350958942448;10819.459027048655;10464.215183861203;10503;10556.155507559377;10561.260711750143;10564.947175264151;7861.174576669453;8030.638621262057;8033.317168040665;10390.896091039107;10611.098056665116;10226.284160108795;10300.27898047137;10390.844137337946;10395.584176632925;10406.115480184193;39807.80096099501;40437;40476.39285410721;40500.59499404998;40684.18631627381;3462.7229821614465;3464.995151406089;3523.1720545672;3782.413725872494;3793.089658481972;29476.852615737;29533.40933181346;30611.23471913198;30675.233119171975;31204.37591248185;3529.2235708144167;3627.3470775260444;3632.291703117893;3687.723420743455;3757.7181711371754;270519;271171;271623;272625;273787.6310618454;61218;61507;61717;61734.382656172864;61751.6912415444;63566;63660.68169659122;63719;63719.72560548763;63729.6270372959;15941.36234550605;16375.09936953479;16398.508044758677;16407.097609631346;16407.753883691756;12433.191842530206;12511.812322815165;12514.937425312815;12519.937400313122;12521.624351269476;19699.901500492404;20368.287109951376;20466.795332046488;20552.691709624367;20560.79439205619;7748;7933.127355990837;7995.520268783892;7998.320142787812;8102.554359510284;899.4693131052579;966.3090890013674;1014.1582486536157;1020.5713600287897;1039.5477967084344;28791.856040720082;28985.42029159405;29163;29163.41673166525;29785.702142978727;981.2003217377815;1033.8604288421118;1052.9473526323652;1070.5824728355947;1085.0343194556851;15438.459653912283;15501.767473487907;15652.68694626101;15958.281877315549;16382.508524744277;319841;321869;322097;322169;438345;46725.831854203236;55226.44773552293;56292.718536407054;56329.71835140798;56358.7182064087;1378.9448422063206;1424.1099312929418;1433.5555977646964;1433.7132573485344;1438.3311760031636;29195.562066568593;29547.55678664865;32134.67865321317;34349.736775006335;34456;51866.740666297934;52483.73758131338;52495.73752131215;52565.211521827965;52570.73714631402;295119;296463;297255;297504;297527;43875.341869871336;43960.560394396925;44615.77692111519;44686.55313446954;44846.77576612096;47069.52930470651;47245;47526.52473475359;47988.520114798404;48211.75894120507;38852;39320.21359572735;39354.2129157421;39559.60440395674;40073.19853602853;38972.6102738969;39221.60778392294;39905;40014.1997160061;40372.1925561493;38452;38493;38613;38632.42051369288;42015.15969680528;33975.490367645;38400;38457.807710961264;39184.80407597944;39232.607673922896;26195.73804261933;26231;26390.208293751217;26581.468370632865;26851.194464166107 07:10:54 INFO - 2015-11-19 07:10:54,994 DEBUG : BROWSER_OUTPUT: |2;jquery.html;343.13701041879676;345.69924165975607;361.4776647744009;363.1755914075051;368.29839156407036;14306.213158276316;14350.784738228935;16599.41902033429;17239.224234909427;18473.90763046186;15063.397464101423;15447.536573902773;15502.224888755545;15834.683306333867;17130.05784681845;5161.458046905077;5288.894222115556;5299.470052994709;5302.178162384817;5303.045451818671;3862.594427585105;3965.2267807777494;5248.580113590922;5294.205869119624;5722.542196624281;5764.827055188351;5766.826995190151;5814.447627475383;5816.621919575236;5820.039693450575;5375.220593013991;5387.622866399353;5391.460853914617;5478.315210598676;5790.04464263396;5126.051680439131;5211.609129315279;5212.087884620177;5212.192110222922;5213.3743950725775;20105;20590.485237869023;20651.27720529774;20769.8961505193;20914.790852091588;2056.23919149914;2108.093519786491;2144.8820314882673;2177.412098733333;2271.7955384015518;13005.479780808757;13097;13237.271950042743;13312.400941957636;13573.52492662752;1796.2096677462005;1839.4297767691924;1860.0141924779753;1881.0218686283056;1892.4417296897311;59830.40169598335;60519;61007.694961525354;61280;62339.37660623426;9493.857592136124;9903;9905.356151850106;9975.60097596088;9987.900120998842;12812.487500500061;12876.678083047811;12893.677658058436;12898.742025159632;12909.806352904714;7548.622568871535;7560.659770310349;7638.694452221849;7654.770356889302;7669.923300766921;6786.660666966632;6839.384455399038;6843.110395648633;6860;7323.780286591411;5886.087656413263;5978.282606087298;5989.940100598938;6009.609375390585;6012.016074483791;1658.5701946648219;1726.4389073551147;1746.1007581095746;1780.6883795336023;1816.373351193836;876.6975393489236;914.4284821986258;936.8688383626162;956.297121615612;1079.6653037558383;16906.830931690525;17167.828321716624;17371.131443428032;17472.475825725247;17488.30046798114;876.5748611923212;978.2760757039739;982.4940155819759;983.4935008470643;988.3180605382263;6386.84032899172;6717.193936727624;6805.319468053254;6808.523403361717;9446.574904129331;540724;541493;549680;555168;560330;76122;77025;77738.22261777309;78052.60973695209;78556.21443785488;582.033823852403;586.0184191479341;586.5776640818603;587.7413937867325;588.8910551547891;10669.933006699268;11089.5564177432;11140.721481963015;11359.375234362189;11518.654440366803;31710.682893171695;31982.200444989063;32647.673523264464;34027.65972340245;35653.82173089118;44948;45077.54922450865;46524;46778.76610616925;47447.76276118597;6735.595864248161;6898.620575868375;6917.7232910685025;6931.341522555551;7002.124734408199;12319.384030798245;12567.560135395583;12709.491620335082;12744.299063551223;12820.29488378111;10656;10716.678499645022;10757.731056723644;11071.944640276746;11132.443377831238;10653.786924261627;10969.286996345212;11017.944910275397;11114.166437517057;11246.718832029264;9034.638614455349;9291.76770580741;10330.121939634915;10484;11344.716382090513;6737.3599508046655;6764.93235067643;6808.28513006147;6838.589684618939;6855.177378714586;10754.193435492525;10819.1344692426;10864.565417383215;11009.724756881142;11074.667759967213 07:10:54 INFO - 2015-11-19 07:10:54,998 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1354.2145555577765;1459.1463993563764;1520.3310543360924;1663.6922169398663;1805.2327760701698;6664.333566643333;6728.293529179439;7177.3899218566485;7507.136679281884;7525.51084179528;7296.598687072209;7435.144958329794;7445.962770186142;7455.813604659873;7456.366208872252;1969.350114462224;2003.6193123306525;2195.802377785999;2268.1381075191402;2308.0998410619786;2295.6326987681973;2303.1017903017837;2303.8041766449874;2307.7230732312146;2311.0986715181007;2221.8777967211795;2292.4498120451053;2295.2769877488536;2295.2999335202758;2297.655351697242;1978.8021197880241;2024.6760518317071;2181.803637672609;2234.4190510467397;2237.015713086253;2279.7150356205475;2288.3363824491043;2309.884505774721;2319.489712263299;2334.3113781434517;7532.284432978859;7586.165521792598;7594.810129746746;7600.657970391346;7603.695852165907;4519.163954668397;4575.039241759235;4577.3362862384765;4595.931061034087;4610.976945115253;3098.2254436390904;3100.1784527100335;3147.35479226758;3210.4542227821325;3286.8356582171036;1163.365965548778;1937.8740381875275;1941.0876887862682;1944.3777991042873;1951.5999220159833;10169.59321627134;10233.027862353065;10237.692869213935;10242.385456872611;10274.33216840903;4143.150654115899;4167.874963751093;4251.936220956688;4256;4260.8508702195895;8419.705310314232;8433.28317093054;8440.366972476966;8440.831183376298;8446.282066024456;4674.298855171752;4680.882977925579;4701.942063035858;4711.269753188261;4711.552402521755;4289.978550107229;4290.377895205178;4322.438083049246;4331.263685173528;4335.631471324973;3358.44585643371;3390.6439823818637;3413.2832105258176;3440.9827950860586;3441.690247877703;1034.4103860799423;1044.738815296176;1049.8897615750388;1059.3855563772993;1088.4938503595865;1032.2722480651123;1041.7760181561;1103.365564800227;1114.6934592986831;1120.6806060272784;7167.964160179165;7194.100737407824;7207.639618019078;7233.819154521179;7235.8552828944175;1209.8427204463364;1223.6465463596764;1236.6228300368473;1249.5446447730071;1263.6019653809205;5510.476504732044;5691.203231547586;5725.5133313667975;5752.683602401824;5765.135229715493;8982.236509896602;9023.593938272663;9052.140046695553;9118.95440522793;9134.360594758304;8867.556622168866;8917.242034427016;9048.366614336934;9059.59231834569;9072.183503484717;6989.545679530815;7073.717051317993;7154.570725756471;7156.212816590275;7157.785266442015;6588.703508342041;6796.524243302922;6819.624920629214;6826.146731658543;6856.24581296047;7839.05931288249;8002.239787220205;8017.8396432072195;8064.8790268147195;8065.233802788725;8036.879446808186;8091.83816323682;8155.714549990722;8248.092709802037;8258.669653213805;6309.4952403806665;6359.07793369968;6370.872582548416;6372.58578192416;6374.681265936777;7249.275072492919;7257.383122434441;7293.708251670086;7303.525270857377;7305.671244794104;6727.798166055026;6762.6280554568;6812.82967925786;6875.862482750217;6931.410830079298;6072.514198863992;6363.395477429637;6774.085498457645;6810.965945170243;6893.93106068953;6838.3161683833205;6848;6853.657317134223;6867.3476019778045;6874;6305.337939516468;6312.652804095819;6316.178896743394;6323.588966717332;6343.9682801585695;6433.099366088658;6457.6771161442675;6460.773872914426;6465.288818229897;6466.547341686037 07:10:54 INFO - 2015-11-19 07:10:54,998 DEBUG : BROWSER_OUTPUT: |4;prototype.html;342.7566427836236;347.27419692841937;349.81984278096786;350.0391425536898;351.5939090350646;6010.308814486335;6093.086037094438;6094.329623741385;6120.938790612098;6145.846353841156;5962.25471816023;6018.488428483573;6027.547933904963;6040.909386359208;6051.7276722547485;4608.5621865922685;4659.720416774988;4698.7415692137;4705.388299521058;4711.740854253015;4680.204365257898;4682.41469816273;4692.741899195543;4692.991006933508;4698.295255711653;4623.491415944261;4630.0739852029565;4639.5360463953675;4645.233536466479;4656.185167595674;4397.186520493703;4488.079943611552;4566.20091483989;4645.094206629708;4659.743714095724;4096.856610018635;4103.261412945669;4120.423140760296;4121.62905338521;4129.69027322952;5500.1749737539285;5687.914681279784;5714.628549144334;5731.713414329267;5740.1102829061565;5224.138017227153;5299.947000529984;5421.9457805421835;5450.209719590677;5456.7544460499375;6373.490120790326;6408;6419.51853610981;6425.421712045938;6425.742970281183;4558.270676691746;4558.58972692456;4560.270356742938;4564.6348292136545;4566.49768525462;6459.61242325462;6637.303083176245;6642.236142843586;6646.102776125258;6659.167604049494;4532.501424843331;4532.773361331921;4562.292844609091;4567.1550763108935;4577.725336479755;4627.542324167876;4631.930521042187;4632.745199014086;4635.58279754817;4644.86065418038;5240.68555886648;5338.252644629755;5346.705931173823;5349.22436246742;5352.9732351338;6454.677266136769;6455.548111632141;6457.2574153971955;6459.741610335534;6461.127747753993;1602.1268408717276;1602.4631748364195;1603.5189443167003;1603.6151323682232;1604.302128574074;1063.0804354233533;1067.556963860005;1080.8162612355918;1081.2809481694585;1085.099367524968;6203.2556093268195;6204.069389591597;6209.844753881189;6210.9068363974575;6213.409726076015;6601.108850305243;6601.70292336846;6613.735450582019;6620.801375958729;6622.304658010936;6057.303410107806;6203.503719702413;6207.099970504251;6211.254649442096;6212.596181248205;3571.4464258040043;3581.982090089533;3589.066842620937;3591.245838373971;3598.8200589970397;6835.453163746988;6837.3162683731225;6842.7605033824575;6845.383915447634;6848;6637.6349300788925;6722.655468906239;6743.1908171019795;6803;6872.725090996404;6875.0718652982205;6884.724611015503;6892.310768923067;6933.861322773617;6935.167779866449;6651.800445986628;6652.334766523309;6661.16735408074;6665.166854143232;6668.733250669919;6455.677216139268;6587.703553340016;6610.10763546915;6614;6615.536912416084;6857.828554286183;6900.861982760417;6903.102596662603;6903.551269167488;6908.827279318058;4527;4550.294704320836;4555.906582420129;4557.225271703752;4571.6799824012;6475.902861456988;6631.270560238467;6632.270450250565;6636.236832764101;6636.634985075674;6486.513511486563;6488.772892948724;6490.870182596227;6493.220813502221;6494.837629059311;6466.676666166579;6471.126397936218;6472.35276472349;6476.838079048061;6476.967615162082;6226.719797609027;6357.8728425432155;6358.109864619049;6359.20509936258;6375.298717141203;6514.57655252407;6518.120053792677;6519.250286217146;6523.967380163069;6525.575837570543;6365.8726825464155;6369.044643303541;6373.840653983688;6377;6377.426031657174 07:10:54 INFO - 2015-11-19 07:10:54,999 DEBUG : BROWSER_OUTPUT: |5;yui.html;813.9987814987561;859.7850537365658;863.248973393148;875.6103533927405;891.9687810926616;13719.588412347633;13908.582742517716;13986.02097853152;13990.16059036456;14000.719985600295;12535.373231338443;13690.657733556665;13695;13698.863011369884;13705.862941370584;695.0894328429748;703.2826516952705;811.7686459359069;824.7154731617583;826.2728798657173;833.0960907415462;838.2958315015386;841.2554888923316;846.0312941681801;846.3863698818338;863.6070587882498;874.8643960186181;875.8029443375221;876.5091548732698;877.8156587116713;716.8673795347877;723.2875617516742;843.363260738145;854.175720429782;864.4683519635441;634.6667999300404;636.6689321552813;636.7994081864198;638.0397501759868;638.533870274702;13756.587302380945;13906.860931390658;13909.374078166507;13916.165030098125;13937.790933136012;11951.462184201731;12100.273983561014;12465.688357791038;12469.376531173404;12554.81167782484;10471.79056418875;10551.841722374094;10629.84055239172;10780.892191078146;10850.45747712619;3602;3631.6368363163474;3668.6514781095752;3676.613955534657;3739.4951681522916;47041;48200.51799482031;48492.51507484915;48495.27257091147;48636.27045594319;10225.59097636101;10239.48802559869;10465.47672616366;10565.9471702641;10749.83875241872;18899.338523151622;18913.527161821065;18948.62102757937;18960.43118706441;19011.80988190128;7653.655585498666;7664.770056898302;7671.6164191790185;7750.534967901944;7863.29230369258;4238.682098842599;4359.411479450297;4359.694821362537;4385.364122202327;4406.779661017001;3119.4852849279614;3121.719045285935;3125.9062228133193;3159.5892533970436;3159.9684003160132;454.0578300027456;462.5536357415111;465.690315939903;483.24372357260773;488.00447087940915;626.7837596029362;680.8365992161846;698.41333280045;710.9786706398817;712.8609921065342;8444.873326900102;8688.304935605136;8843.734687959372;8918.464892106495;8948.10518948113;546.5354448718557;570.6091327440716;572.7794799002414;576.4120596991129;580.3529065092391;3997.9000524986527;4139.606737359946;4203.852865149705;4381.561843815657;4478.619317357996;56222;56950;61074.69462652658;61128.38871611227;61477.38522614806;48933.266001010015;49114.754426228355;49342.50657493451;49670.25494617584;49781;46287;47760;49104.7544762281;49552.75223623931;50153.74923125361;8840.115988401109;8928.598213080297;9367.030829835505;9444.622215111318;9487.620495180116;34669.47995780015;34969.99999999898;35644.28711425809;35942.8202858984;36201.45697814588;43424;45160;47639.28541071817;47912;48223.51776482331;8261.17388261193;8408.201220884006;8493.278071364004;8756.38705290649;8824.382293239412;12356.938215308866;12583.685407864876;12676.23942563449;12766.29785361814;12864.742705145658;11126.332420054823;11250.437478126225;11293;11685.415729213675;12061.396930153282;11739.706507337385;11834.408279585814;12007.399630018639;12121.757564848478;12553.121281510206;11523.366214857928;11768.35274059935;12008.279503229835;12214.328211948072;12292.078094142797;9952.900470995197;10032.498375081363;10106.01199609426;10181.694549163536;10525.9473702631;8847.42491738035;9609.279304052085;9617.855732164164;9690;9725.297743730844 07:10:54 INFO - 2015-11-19 07:10:54,999 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:55 INFO - 2015-11-19 07:10:54,999 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:55 INFO - 2015-11-19 07:10:54,999 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,956 07:10:55 INFO - 2015-11-19 07:10:54,999 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:55 INFO - 2015-11-19 07:10:54,999 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945854986__endTimestamp 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5457.08 Median:5657.46 stddev:604.57 (10.7%) stddev-sans-first:580.60 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: Values: 3228.8 3283.7 3320.3 3331.0 3334.6 5204.7 5290.2 5426.3 5427.0 5458.7 5373.8 5398.5 5470.7 5478.6 5494.0 4914.0 4950.9 5087.6 5092.4 5123.3 4848.0 5049.2 5084.0 5097.6 5122.4 4899.8 4964.7 4974.4 5001.5 5022.0 4969.8 4970.1 4978.1 4999.6 5027.9 4814.3 4949.7 4969.3 4979.4 5014.6 5192.2 5324.9 5325.4 5325.9 5361.3 5918.9 5924.3 5924.7 5932.3 5939.7 5864.6 5870.4 5947.5 5951.9 5999.5 5503.9 5513.3 5513.8 5521.1 5550.4 5971.0 6002.5 6019.7 6020.4 6021.7 5644.6 5754.6 5795.5 5859.3 5915.8 5928.3 5946.4 5948.9 5951.6 5955.3 5919.3 5938.4 5945.8 5946.9 5948.7 5728.3 5783.9 5878.4 5878.4 5922.0 4522.4 4539.7 4549.0 4571.3 4587.5 4021.9 4027.9 4034.6 4045.1 4073.5 5395.9 5489.1 5502.6 5578.4 5595.6 5803.6 5809.0 5813.7 5858.0 5947.0 5519.8 5521.1 5521.7 5524.5 5532.2 4991.1 5071.9 5107.3 5120.1 5181.0 6106.9 6110.9 6114.0 6120.4 6132.4 5907.5 5913.2 5919.1 5925.3 5925.9 5834.6 5950.2 5965.0 5966.2 6092.8 5790.7 5853.2 5854.9 5859.4 5863.6 5915.8 5923.3 5931.1 5938.8 5940.4 5539.7 5653.0 5693.6 5699.0 5775.5 5689.0 5698.4 5742.6 5742.8 5746.2 5650.3 5655.0 5665.9 5666.2 5669.7 5624.4 5657.5 5743.0 5783.5 5788.9 5627.5 5676.9 5682.2 5687.7 5691.3 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49088.07 Median:3660.01 stddev:80237.13 (2192.3%) stddev-sans-first:80379.57 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: Values: 584.6 585.3 586.7 587.4 590.8 31641.0 39729.8 40352.0 40445.0 40458.4 43145.8 43681.0 43688.3 43767.0 43799.6 7647.6 7788.8 8683.7 8794.4 8809.6 10497.0 10805.4 10817.0 10817.4 10819.5 10464.2 10503.0 10556.2 10561.3 10564.9 7861.2 8030.6 8033.3 10390.9 10611.1 10226.3 10300.3 10390.8 10395.6 10406.1 39807.8 40437.0 40476.4 40500.6 40684.2 3462.7 3465.0 3523.2 3782.4 3793.1 29476.9 29533.4 30611.2 30675.2 31204.4 3529.2 3627.3 3632.3 3687.7 3757.7 270519.0 271171.0 271623.0 272625.0 273787.6 61218.0 61507.0 61717.0 61734.4 61751.7 63566.0 63660.7 63719.0 63719.7 63729.6 15941.4 16375.1 16398.5 16407.1 16407.8 12433.2 12511.8 12514.9 12519.9 12521.6 19699.9 20368.3 20466.8 20552.7 20560.8 7748.0 7933.1 7995.5 7998.3 8102.6 899.5 966.3 1014.2 1020.6 1039.5 28791.9 28985.4 29163.0 29163.4 29785.7 981.2 1033.9 1052.9 1070.6 1085.0 15438.5 15501.8 15652.7 15958.3 16382.5 319841.0 321869.0 322097.0 322169.0 438345.0 46725.8 55226.4 56292.7 56329.7 56358.7 1378.9 1424.1 1433.6 1433.7 1438.3 29195.6 29547.6 32134.7 34349.7 34456.0 51866.7 52483.7 52495.7 52565.2 52570.7 295119.0 296463.0 297255.0 297504.0 297527.0 43875.3 43960.6 44615.8 44686.6 44846.8 47069.5 47245.0 47526.5 47988.5 48211.8 38852.0 39320.2 39354.2 39559.6 40073.2 38972.6 39221.6 39905.0 40014.2 40372.2 38452.0 38493.0 38613.0 38632.4 42015.2 33975.5 38400.0 38457.8 39184.8 39232.6 26195.7 26231.0 26390.2 26581.5 26851.2 07:10:55 INFO - 2015-11-19 07:10:55,000 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,001 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28235.23 Median:26286.91 stddev:89865.73 (341.9%) stddev-sans-first:90093.42 07:10:55 INFO - 2015-11-19 07:10:55,002 DEBUG : BROWSER_OUTPUT: Values: 343.1 345.7 361.5 363.2 368.3 14306.2 14350.8 16599.4 17239.2 18473.9 15063.4 15447.5 15502.2 15834.7 17130.1 5161.5 5288.9 5299.5 5302.2 5303.0 3862.6 3965.2 5248.6 5294.2 5722.5 5764.8 5766.8 5814.4 5816.6 5820.0 5375.2 5387.6 5391.5 5478.3 5790.0 5126.1 5211.6 5212.1 5212.2 5213.4 20105.0 20590.5 20651.3 20769.9 20914.8 2056.2 2108.1 2144.9 2177.4 2271.8 13005.5 13097.0 13237.3 13312.4 13573.5 1796.2 1839.4 1860.0 1881.0 1892.4 59830.4 60519.0 61007.7 61280.0 62339.4 9493.9 9903.0 9905.4 9975.6 9987.9 12812.5 12876.7 12893.7 12898.7 12909.8 7548.6 7560.7 7638.7 7654.8 7669.9 6786.7 6839.4 6843.1 6860.0 7323.8 5886.1 5978.3 5989.9 6009.6 6012.0 1658.6 1726.4 1746.1 1780.7 1816.4 876.7 914.4 936.9 956.3 1079.7 16906.8 17167.8 17371.1 17472.5 17488.3 876.6 978.3 982.5 983.5 988.3 6386.8 6717.2 6805.3 6808.5 9446.6 540724.0 541493.0 549680.0 555168.0 560330.0 76122.0 77025.0 77738.2 78052.6 78556.2 582.0 586.0 586.6 587.7 588.9 10669.9 11089.6 11140.7 11359.4 11518.7 31710.7 31982.2 32647.7 34027.7 35653.8 44948.0 45077.5 46524.0 46778.8 47447.8 6735.6 6898.6 6917.7 6931.3 7002.1 12319.4 12567.6 12709.5 12744.3 12820.3 10656.0 10716.7 10757.7 11071.9 11132.4 10653.8 10969.3 11017.9 11114.2 11246.7 9034.6 9291.8 10330.1 10484.0 11344.7 6737.4 6764.9 6808.3 6838.6 6855.2 10754.2 10819.1 10864.6 11009.7 11074.7 07:10:55 INFO - 2015-11-19 07:10:55,002 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,002 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5298.13 Median:6188.93 stddev:2646.44 (42.8%) stddev-sans-first:2637.26 07:10:55 INFO - 2015-11-19 07:10:55,002 DEBUG : BROWSER_OUTPUT: Values: 1354.2 1459.1 1520.3 1663.7 1805.2 6664.3 6728.3 7177.4 7507.1 7525.5 7296.6 7435.1 7446.0 7455.8 7456.4 1969.4 2003.6 2195.8 2268.1 2308.1 2295.6 2303.1 2303.8 2307.7 2311.1 2221.9 2292.4 2295.3 2295.3 2297.7 1978.8 2024.7 2181.8 2234.4 2237.0 2279.7 2288.3 2309.9 2319.5 2334.3 7532.3 7586.2 7594.8 7600.7 7603.7 4519.2 4575.0 4577.3 4595.9 4611.0 3098.2 3100.2 3147.4 3210.5 3286.8 1163.4 1937.9 1941.1 1944.4 1951.6 10169.6 10233.0 10237.7 10242.4 10274.3 4143.2 4167.9 4251.9 4256.0 4260.9 8419.7 8433.3 8440.4 8440.8 8446.3 4674.3 4680.9 4701.9 4711.3 4711.6 4290.0 4290.4 4322.4 4331.3 4335.6 3358.4 3390.6 3413.3 3441.0 3441.7 1034.4 1044.7 1049.9 1059.4 1088.5 1032.3 1041.8 1103.4 1114.7 1120.7 7168.0 7194.1 7207.6 7233.8 7235.9 1209.8 1223.6 1236.6 1249.5 1263.6 5510.5 5691.2 5725.5 5752.7 5765.1 8982.2 9023.6 9052.1 9119.0 9134.4 8867.6 8917.2 9048.4 9059.6 9072.2 6989.5 7073.7 7154.6 7156.2 7157.8 6588.7 6796.5 6819.6 6826.1 6856.2 7839.1 8002.2 8017.8 8064.9 8065.2 8036.9 8091.8 8155.7 8248.1 8258.7 6309.5 6359.1 6370.9 6372.6 6374.7 7249.3 7257.4 7293.7 7303.5 7305.7 6727.8 6762.6 6812.8 6875.9 6931.4 6072.5 6363.4 6774.1 6811.0 6893.9 6838.3 6848.0 6853.7 6867.3 6874.0 6305.3 6312.7 6316.2 6323.6 6344.0 6433.1 6457.7 6460.8 6465.3 6466.5 07:10:55 INFO - 2015-11-19 07:10:55,002 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,003 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5388.19 Median:6174.55 stddev:1622.20 (26.3%) stddev-sans-first:1581.93 07:10:55 INFO - 2015-11-19 07:10:55,004 DEBUG : BROWSER_OUTPUT: Values: 342.8 347.3 349.8 350.0 351.6 6010.3 6093.1 6094.3 6120.9 6145.8 5962.3 6018.5 6027.5 6040.9 6051.7 4608.6 4659.7 4698.7 4705.4 4711.7 4680.2 4682.4 4692.7 4693.0 4698.3 4623.5 4630.1 4639.5 4645.2 4656.2 4397.2 4488.1 4566.2 4645.1 4659.7 4096.9 4103.3 4120.4 4121.6 4129.7 5500.2 5687.9 5714.6 5731.7 5740.1 5224.1 5299.9 5421.9 5450.2 5456.8 6373.5 6408.0 6419.5 6425.4 6425.7 4558.3 4558.6 4560.3 4564.6 4566.5 6459.6 6637.3 6642.2 6646.1 6659.2 4532.5 4532.8 4562.3 4567.2 4577.7 4627.5 4631.9 4632.7 4635.6 4644.9 5240.7 5338.3 5346.7 5349.2 5353.0 6454.7 6455.5 6457.3 6459.7 6461.1 1602.1 1602.5 1603.5 1603.6 1604.3 1063.1 1067.6 1080.8 1081.3 1085.1 6203.3 6204.1 6209.8 6210.9 6213.4 6601.1 6601.7 6613.7 6620.8 6622.3 6057.3 6203.5 6207.1 6211.3 6212.6 3571.4 3582.0 3589.1 3591.2 3598.8 6835.5 6837.3 6842.8 6845.4 6848.0 6637.6 6722.7 6743.2 6803.0 6872.7 6875.1 6884.7 6892.3 6933.9 6935.2 6651.8 6652.3 6661.2 6665.2 6668.7 6455.7 6587.7 6610.1 6614.0 6615.5 6857.8 6900.9 6903.1 6903.6 6908.8 4527.0 4550.3 4555.9 4557.2 4571.7 6475.9 6631.3 6632.3 6636.2 6636.6 6486.5 6488.8 6490.9 6493.2 6494.8 6466.7 6471.1 6472.4 6476.8 6477.0 6226.7 6357.9 6358.1 6359.2 6375.3 6514.6 6518.1 6519.3 6524.0 6525.6 6365.9 6369.0 6373.8 6377.0 6377.4 07:10:55 INFO - 2015-11-19 07:10:55,004 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,004 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14028.65 Median:47340.14 stddev:16223.49 (34.3%) stddev-sans-first:16238.65 07:10:55 INFO - 2015-11-19 07:10:55,004 DEBUG : BROWSER_OUTPUT: Values: 814.0 859.8 863.2 875.6 892.0 13719.6 13908.6 13986.0 13990.2 14000.7 12535.4 13690.7 13695.0 13698.9 13705.9 695.1 703.3 811.8 824.7 826.3 833.1 838.3 841.3 846.0 846.4 863.6 874.9 875.8 876.5 877.8 716.9 723.3 843.4 854.2 864.5 634.7 636.7 636.8 638.0 638.5 13756.6 13906.9 13909.4 13916.2 13937.8 11951.5 12100.3 12465.7 12469.4 12554.8 10471.8 10551.8 10629.8 10780.9 10850.5 3602.0 3631.6 3668.7 3676.6 3739.5 47041.0 48200.5 48492.5 48495.3 48636.3 10225.6 10239.5 10465.5 10565.9 10749.8 18899.3 18913.5 18948.6 18960.4 19011.8 7653.7 7664.8 7671.6 7750.5 7863.3 4238.7 4359.4 4359.7 4385.4 4406.8 3119.5 3121.7 3125.9 3159.6 3160.0 454.1 462.6 465.7 483.2 488.0 626.8 680.8 698.4 711.0 712.9 8444.9 8688.3 8843.7 8918.5 8948.1 546.5 570.6 572.8 576.4 580.4 3997.9 4139.6 4203.9 4381.6 4478.6 56222.0 56950.0 61074.7 61128.4 61477.4 48933.3 49114.8 49342.5 49670.3 49781.0 46287.0 47760.0 49104.8 49552.8 50153.7 8840.1 8928.6 9367.0 9444.6 9487.6 34669.5 34970.0 35644.3 35942.8 36201.5 43424.0 45160.0 47639.3 47912.0 48223.5 8261.2 8408.2 8493.3 8756.4 8824.4 12356.9 12583.7 12676.2 12766.3 12864.7 11126.3 11250.4 11293.0 11685.4 12061.4 11739.7 11834.4 12007.4 12121.8 12553.1 11523.4 11768.4 12008.3 12214.3 12292.1 9952.9 10032.5 10106.0 10181.7 10525.9 8847.4 9609.3 9617.9 9690.0 9725.3 07:10:55 INFO - 2015-11-19 07:10:55,004 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:55 INFO - 2015-11-19 07:10:55,004 DEBUG : BROWSER_OUTPUT: 07:10:55 INFO - 2015-11-19 07:10:55,621 INFO : Browser exited with error code: 0 07:10:55 INFO - 2015-11-19 07:10:55,638 INFO : Completed test dromaeo_css (00:18:35) 07:10:55 INFO - 2015-11-19 07:10:55,638 INFO : Starting test kraken 07:10:55 INFO - 2015-11-19 07:10:55,638 DEBUG : operating with platform_type : linux_ 07:10:55 INFO - 2015-11-19 07:10:55,638 INFO : Initialising browser for kraken test... 07:10:55 INFO - 2015-11-19 07:10:55,644 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQSIMwh/profile http://localhost:56446/getInfo.html 07:10:59 INFO - 2015-11-19 07:10:59,320 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:59 INFO - 2015-11-19 07:10:59,321 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:59 INFO - 2015-11-19 07:10:59,321 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:59 INFO - 2015-11-19 07:10:59,321 DEBUG : BROWSER_OUTPUT: __metrics 07:10:59 INFO - 2015-11-19 07:10:59,409 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:00 INFO - 2015-11-19 07:11:00,649 INFO : Browser initialized. 07:11:00 INFO - 2015-11-19 07:11:00,649 INFO : Running cycle 1/1 for kraken test... 07:11:00 INFO - 2015-11-19 07:11:00,650 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQSIMwh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:11:12 INFO - 2015-11-19 07:11:12,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 07:11:12 INFO - 2015-11-19 07:11:12,381 DEBUG : BROWSER_OUTPUT: 07:11:14 INFO - 2015-11-19 07:11:14,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:15 INFO - 2015-11-19 07:11:15,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 180273152 07:11:15 INFO - 2015-11-19 07:11:15,469 DEBUG : BROWSER_OUTPUT: 07:11:18 INFO - 2015-11-19 07:11:18,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-dft) 07:11:18 INFO - 2015-11-19 07:11:18,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 168960000 07:11:18 INFO - 2015-11-19 07:11:18,631 DEBUG : BROWSER_OUTPUT: 07:11:21 INFO - 2015-11-19 07:11:21,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-fft) 07:11:22 INFO - 2015-11-19 07:11:22,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 151375872 07:11:22 INFO - 2015-11-19 07:11:22,064 DEBUG : BROWSER_OUTPUT: 07:11:24 INFO - 2015-11-19 07:11:24,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-oscillator) 07:11:24 INFO - 2015-11-19 07:11:24,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 154243072 07:11:24 INFO - 2015-11-19 07:11:24,626 DEBUG : BROWSER_OUTPUT: 07:11:26 INFO - 2015-11-19 07:11:26,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:27 INFO - 2015-11-19 07:11:27,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 156434432 07:11:27 INFO - 2015-11-19 07:11:27,358 DEBUG : BROWSER_OUTPUT: 07:11:30 INFO - 2015-11-19 07:11:30,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56446/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:30 INFO - 2015-11-19 07:11:30,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 156127232 07:11:30 INFO - 2015-11-19 07:11:30,834 DEBUG : BROWSER_OUTPUT: 07:11:34 INFO - 2015-11-19 07:11:34,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56446/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:34 INFO - 2015-11-19 07:11:34,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 156581888 07:11:34 INFO - 2015-11-19 07:11:34,795 DEBUG : BROWSER_OUTPUT: 07:11:37 INFO - 2015-11-19 07:11:37,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56446/tests/kraken/driver.html?testName=json-parse-financial) 07:11:38 INFO - 2015-11-19 07:11:38,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 156897280 07:11:38 INFO - 2015-11-19 07:11:38,123 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-19 07:11:39,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:40 INFO - 2015-11-19 07:11:40,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 166625280 07:11:40 INFO - 2015-11-19 07:11:40,252 DEBUG : BROWSER_OUTPUT: 07:11:42 INFO - 2015-11-19 07:11:42,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:42 INFO - 2015-11-19 07:11:42,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 168235008 07:11:42 INFO - 2015-11-19 07:11:42,671 DEBUG : BROWSER_OUTPUT: 07:11:44 INFO - 2015-11-19 07:11:44,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:45 INFO - 2015-11-19 07:11:45,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 174845952 07:11:45 INFO - 2015-11-19 07:11:45,309 DEBUG : BROWSER_OUTPUT: 07:11:47 INFO - 2015-11-19 07:11:47,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:48 INFO - 2015-11-19 07:11:48,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 183324672 07:11:48 INFO - 2015-11-19 07:11:48,526 DEBUG : BROWSER_OUTPUT: 07:11:51 INFO - 2015-11-19 07:11:51,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:51 INFO - 2015-11-19 07:11:51,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 177598464 07:11:51 INFO - 2015-11-19 07:11:51,679 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56446/tests/kraken/driver.html?testName=ai-astar) 07:11:53 INFO - 2015-11-19 07:11:53,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 237694976 07:11:53 INFO - 2015-11-19 07:11:53,596 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,597 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:53 INFO - 2015-11-19 07:11:53,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:53 INFO - 2015-11-19 07:11:53,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:53 INFO - 2015-11-19 07:11:53,598 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:53 INFO - 2015-11-19 07:11:53,598 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;110;109;109;117;110;109;110;110 07:11:53 INFO - 2015-11-19 07:11:53,599 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;152;169;124;146;157;126;159;123 07:11:53 INFO - 2015-11-19 07:11:53,599 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;160;160;159;159;164;160;162 07:11:53 INFO - 2015-11-19 07:11:53,599 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;85;91;73;71;72;96;88;71 07:11:53 INFO - 2015-11-19 07:11:53,599 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;131;90;91;90;136;89;90;141 07:11:53 INFO - 2015-11-19 07:11:53,599 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;108;110;110;109;109 07:11:53 INFO - 2015-11-19 07:11:53,600 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;145;145;145;145;147;146;146;145 07:11:53 INFO - 2015-11-19 07:11:53,600 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;96;97;96;95 07:11:53 INFO - 2015-11-19 07:11:53,600 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;56;58;58;58;58;58;65;55;55 07:11:53 INFO - 2015-11-19 07:11:53,600 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;70;70;69;69;70 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;93;92;87;85;86;86;85 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;122;126;112;119;118;126;115;124;125 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;150;150;155;152;140;149;150;147;139 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;72;69;70;68;66;67;67;67;66 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:11:53 INFO - 2015-11-19 07:11:53,601 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 07:11:53 INFO - 2015-11-19 07:11:53,602 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:11:53 INFO - 2015-11-19 07:11:53,602 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945913596__endTimestamp 07:11:53 INFO - 2015-11-19 07:11:53,602 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,605 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:53 INFO - 2015-11-19 07:11:53,605 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:11:53 INFO - 2015-11-19 07:11:53,605 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,605 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:2.75 (2.5%) stddev-sans-first:2.92 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 110.0 109.0 109.0 117.0 110.0 109.0 110.0 110.0 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.90 Median:150.50 stddev:17.21 (11.4%) stddev-sans-first:18.11 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 152.0 169.0 124.0 146.0 157.0 126.0 159.0 123.0 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.62 (1.0%) stddev-sans-first:1.66 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 160.0 160.0 159.0 159.0 164.0 160.0 162.0 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,606 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:79.00 stddev:9.95 (12.6%) stddev-sans-first:10.13 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 85.0 91.0 73.0 71.0 72.0 96.0 88.0 71.0 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:90.00 stddev:22.42 (24.9%) stddev-sans-first:23.14 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 131.0 90.0 91.0 90.0 136.0 89.0 90.0 141.0 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 108.0 110.0 110.0 109.0 109.0 07:11:53 INFO - 2015-11-19 07:11:53,607 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,608 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 07:11:53 INFO - 2015-11-19 07:11:53,608 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 145.0 145.0 145.0 145.0 147.0 146.0 146.0 145.0 07:11:53 INFO - 2015-11-19 07:11:53,608 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,608 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:11:53 INFO - 2015-11-19 07:11:53,608 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:2.83 (4.9%) stddev-sans-first:2.98 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: Values: 59.0 56.0 58.0 58.0 58.0 58.0 58.0 65.0 55.0 55.0 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 70.0 70.0 69.0 69.0 70.0 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:3.07 (3.6%) stddev-sans-first:3.07 07:11:53 INFO - 2015-11-19 07:11:53,609 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 93.0 92.0 87.0 85.0 86.0 86.0 85.0 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:123.00 stddev:4.81 (3.9%) stddev-sans-first:5.07 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: Values: 119.0 122.0 126.0 112.0 119.0 118.0 126.0 115.0 124.0 125.0 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:150.00 stddev:5.03 (3.4%) stddev-sans-first:5.29 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: Values: 146.0 150.0 150.0 155.0 152.0 140.0 149.0 150.0 147.0 139.0 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:2.00 07:11:53 INFO - 2015-11-19 07:11:53,610 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 69.0 70.0 68.0 66.0 67.0 67.0 67.0 66.0 07:11:53 INFO - 2015-11-19 07:11:53,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:53 INFO - 2015-11-19 07:11:53,611 DEBUG : BROWSER_OUTPUT: 07:11:54 INFO - 2015-11-19 07:11:54,421 INFO : Browser exited with error code: 0 07:11:54 INFO - 2015-11-19 07:11:54,475 INFO : Completed test kraken (00:00:58) 07:11:54 INFO - 2015-11-19 07:11:54,476 INFO : Starting test v8_7 07:11:54 INFO - 2015-11-19 07:11:54,476 DEBUG : operating with platform_type : linux_ 07:11:54 INFO - 2015-11-19 07:11:54,476 INFO : Initialising browser for v8_7 test... 07:11:54 INFO - 2015-11-19 07:11:54,482 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSIDaq7/profile http://localhost:56446/getInfo.html 07:11:58 INFO - 2015-11-19 07:11:58,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:11:58 INFO - 2015-11-19 07:11:58,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:11:58 INFO - 2015-11-19 07:11:58,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:11:58 INFO - 2015-11-19 07:11:58,077 DEBUG : BROWSER_OUTPUT: __metrics 07:11:58 INFO - 2015-11-19 07:11:58,213 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:59 INFO - 2015-11-19 07:11:59,454 INFO : Browser initialized. 07:11:59 INFO - 2015-11-19 07:11:59,454 INFO : Running cycle 1/1 for v8_7 test... 07:11:59 INFO - 2015-11-19 07:11:59,455 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSIDaq7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:12:11 INFO - 2015-11-19 07:12:11,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 07:12:11 INFO - 2015-11-19 07:12:11,221 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56446/tests/v8_7/run.html (next: http://localhost:56446/tests/v8_7/run.html) 07:12:32 INFO - 2015-11-19 07:12:32,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 498896896 07:12:32 INFO - 2015-11-19 07:12:32,931 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,932 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:12:32 INFO - 2015-11-19 07:12:32,932 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:12:32 INFO - 2015-11-19 07:12:32,933 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:12:32 INFO - 2015-11-19 07:12:32,933 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:12:32 INFO - 2015-11-19 07:12:32,933 DEBUG : BROWSER_OUTPUT: |0;Richards;168.66250632484397 07:12:32 INFO - 2015-11-19 07:12:32,933 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.0359168241966 07:12:32 INFO - 2015-11-19 07:12:32,933 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.7254735651682 07:12:32 INFO - 2015-11-19 07:12:32,933 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 07:12:32 INFO - 2015-11-19 07:12:32,934 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 07:12:32 INFO - 2015-11-19 07:12:32,934 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 07:12:32 INFO - 2015-11-19 07:12:32,934 DEBUG : BROWSER_OUTPUT: |6;Boyer;12365.853658536585 07:12:32 INFO - 2015-11-19 07:12:32,934 DEBUG : BROWSER_OUTPUT: |7;RegExp;27540.54054054054 07:12:32 INFO - 2015-11-19 07:12:32,935 DEBUG : BROWSER_OUTPUT: |8;Splay;1335.1134846461948 07:12:32 INFO - 2015-11-19 07:12:32,935 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 07:12:32 INFO - 2015-11-19 07:12:32,935 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:12:32 INFO - 2015-11-19 07:12:32,935 DEBUG : BROWSER_OUTPUT: __startTimestamp1447945952931__endTimestamp 07:12:32 INFO - 2015-11-19 07:12:32,935 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,936 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:12:32 INFO - 2015-11-19 07:12:32,936 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:12:32 INFO - 2015-11-19 07:12:32,936 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,936 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.66 Median:168.66 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: Values: 168.7 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.04 Median:189.04 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: Values: 189.0 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.73 Median:282.73 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: Values: 282.7 07:12:32 INFO - 2015-11-19 07:12:32,937 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: Values: 5040.2 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: Values: 1990.1 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: Values: 788.0 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: Values: 12365.9 07:12:32 INFO - 2015-11-19 07:12:32,938 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27540.54 Median:27540.54 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: Values: 27540.5 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1335.11 Median:1335.11 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: Values: 1335.1 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: Values: 4850.2 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:12:32 INFO - 2015-11-19 07:12:32,939 DEBUG : BROWSER_OUTPUT: 07:12:33 INFO - 2015-11-19 07:12:33,785 INFO : Browser exited with error code: 0 07:12:33 INFO - 2015-11-19 07:12:33,802 INFO : Completed test v8_7 (00:00:39) 07:12:33 INFO - 2015-11-19 07:12:33,928 INFO : Completed test suite (00:20:13) 07:12:33 INFO - 2015-11-19 07:12:33,928 DEBUG : Working with test: dromaeo_css 07:12:33 INFO - 2015-11-19 07:12:33,928 DEBUG : Generating results file: dromaeo_css 07:12:33 INFO - 2015-11-19 07:12:33,929 DEBUG : Working with test: kraken 07:12:33 INFO - 2015-11-19 07:12:33,929 DEBUG : Generating results file: kraken 07:12:33 INFO - 2015-11-19 07:12:33,930 INFO : javascript benchmark 07:12:33 INFO - 2015-11-19 07:12:33,930 DEBUG : Working with test: v8_7 07:12:33 INFO - 2015-11-19 07:12:33,930 DEBUG : Generating results file: v8_7 07:12:33 INFO - 2015-11-19 07:12:33,930 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:33 INFO - 2015-11-19 07:12:33,986 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 07:12:33 INFO - 2015-11-19 07:12:33,986 DEBUG : process_Request line: dromaeo_css 7017.42 graph.html#tests=[[72,64,35]] 07:12:33 INFO - 2015-11-19 07:12:33,986 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:34 INFO - 2015-11-19 07:12:34,019 DEBUG : process_Request line: kraken 1497.60 graph.html#tests=[[232,64,35]] 07:12:34 INFO - 2015-11-19 07:12:34,019 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:34 INFO - 2015-11-19 07:12:34,052 DEBUG : process_Request line: v8_7 18198.01 graph.html#tests=[[230,64,35]] 07:12:34 INFO - 2015-11-19 07:12:34,054 INFO : javascript benchmark 07:12:34 INFO - 2015-11-19 07:12:34,057 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3228.8062716237027, 3283.6716328367165, 3320.3027364253508, 3330.9500357494626, 3334.649861764514, 5204.687718736869, 5290.206469029647, 5426.321709786277, 5427.0, 5458.7270636468165, 5373.838784836461, 5398.4601539846, 5470.72646367681, 5478.561715062795, 5493.972530137354, 4913.950860491403, 4950.925736113961, 5087.643864929457, 5092.414372347172, 5123.333966584339, 4848.0, 5049.2173713074535, 5083.974580127094, 5097.643164978453, 5122.436531981498, 4899.755012249373, 4964.67729597575, 4974.3533340665845, 5001.474845141281, 5022.045811295842, 4969.776360063805, 4970.130227210224, 4978.079055374767, 4999.575036121934, 5027.899442011139, 4814.277858321245, 4949.653524253267, 4969.27945447908, 4979.3526841510375, 5014.59883209346, 5192.247124167013, 5324.920126198072, 5325.360956685184, 5325.946740532622, 5361.276227709248, 5918.8816223675285, 5924.289085309747, 5924.7333869975955, 5932.2584676915385, 5939.67331796751, 5864.5894787364905, 5870.442307980735, 5947.494462970652, 5951.9107213391835, 5999.520038396961, 5503.9174412383845, 5513.283273174542, 5513.807016754395, 5521.061419558685, 5550.4449555044575, 5971.014782560829, 6002.4897883679505, 6019.729112189962, 6020.4280593343565, 6021.668808215591, 5644.576656750678, 5754.5971781975695, 5795.536357091422, 5859.296884373903, 5915.763369465173, 5928.318243402064, 5946.375630558816, 5948.940510594839, 5951.613145145551, 5955.28536575605, 5919.260092488439, 5938.406159384113, 5945.762169513171, 5946.8810623787285, 5948.67282299469, 5728.341240757283, 5783.884322313615, 5878.353381128158, 5878.382769809194, 5921.970390148022, 4522.389477420572, 4539.72761634303, 4548.976480291908, 4571.291449825282, 4587.472440669299, 4021.939670904939, 4027.91944161121, 4034.616711412411, 4045.110075783323, 4073.490813648294, 5395.892082158335, 5489.149181876815, 5502.614816962854, 5578.44215578447, 5595.552355811526, 5803.564732645069, 5809.0, 5813.738381772746, 5857.970710146422, 5946.970265148647, 5519.751611177507, 5521.116621340566, 5521.668699878021, 5524.530414914777, 5532.197831314517, 4991.07665081961, 5071.949280507221, 5107.33604631403, 5120.078385890501, 5181.0, 6106.908396374147, 6110.938890611037, 6114.0, 6120.44915957566, 6132.356102609251, 5907.468327850343, 5913.172155898092, 5919.052951527735, 5925.348211696796, 5925.881482370242, 5834.562407819515, 5950.19672344228, 5965.0, 5966.164736936919, 6092.786752463642, 5790.652560846363, 5853.239078919713, 5854.94145058561, 5859.384764599656, 5863.560232982629, 5915.822525324247, 5923.259592550931, 5931.110333450017, 5938.8218353449465, 5940.376260492586, 5539.667619942817, 5653.038983372754, 5693.629914055573, 5699.0, 5775.509081727932, 5689.0, 5698.430156984434, 5742.569307302053, 5742.7702891883855, 5746.224259725051, 5650.29371328584, 5655.0, 5665.858353541194, 5666.206731057738, 5669.659820410789, 5624.381318055092, 5657.462541058593, 5743.0, 5783.537317014545, 5788.942110578841, 5627.493525582717, 5676.914846277226, 5682.176084467812, 5687.687177205294, 5691.345495267931], "unit": "ms", "name": "dojo.html", "value": 5418.090940385624}, {"lowerIsBetter": false, "replicates": [584.6170758153409, 585.2947198625657, 586.6626689653448, 587.3656451032884, 590.8493334199778, 31641.0, 39729.80135099328, 40352.0, 40445.0, 40458.393124103124, 43145.7842710786, 43681.0, 43688.3446748299, 43767.0, 43799.56200437995, 7647.617619119022, 7788.844223115534, 8683.696070637528, 8794.384393092487, 8809.603567839431, 10497.0, 10805.351678899251, 10817.0, 10817.350958942448, 10819.459027048655, 10464.215183861203, 10503.0, 10556.155507559377, 10561.260711750143, 10564.947175264151, 7861.174576669453, 8030.638621262057, 8033.317168040665, 10390.896091039107, 10611.098056665116, 10226.284160108795, 10300.27898047137, 10390.844137337946, 10395.584176632925, 10406.115480184193, 39807.80096099501, 40437.0, 40476.39285410721, 40500.59499404998, 40684.18631627381, 3462.7229821614465, 3464.995151406089, 3523.1720545672, 3782.413725872494, 3793.089658481972, 29476.852615737, 29533.40933181346, 30611.23471913198, 30675.233119171975, 31204.37591248185, 3529.2235708144167, 3627.3470775260444, 3632.291703117893, 3687.723420743455, 3757.7181711371754, 270519.0, 271171.0, 271623.0, 272625.0, 273787.6310618454, 61218.0, 61507.0, 61717.0, 61734.382656172864, 61751.6912415444, 63566.0, 63660.68169659122, 63719.0, 63719.72560548763, 63729.6270372959, 15941.36234550605, 16375.09936953479, 16398.508044758677, 16407.097609631346, 16407.753883691756, 12433.191842530206, 12511.812322815165, 12514.937425312815, 12519.937400313122, 12521.624351269476, 19699.901500492404, 20368.287109951376, 20466.795332046488, 20552.691709624367, 20560.79439205619, 7748.0, 7933.127355990837, 7995.520268783892, 7998.320142787812, 8102.554359510284, 899.4693131052579, 966.3090890013674, 1014.1582486536157, 1020.5713600287897, 1039.5477967084344, 28791.856040720082, 28985.42029159405, 29163.0, 29163.41673166525, 29785.702142978727, 981.2003217377815, 1033.8604288421118, 1052.9473526323652, 1070.5824728355947, 1085.0343194556851, 15438.459653912283, 15501.767473487907, 15652.68694626101, 15958.281877315549, 16382.508524744277, 319841.0, 321869.0, 322097.0, 322169.0, 438345.0, 46725.831854203236, 55226.44773552293, 56292.718536407054, 56329.71835140798, 56358.7182064087, 1378.9448422063206, 1424.1099312929418, 1433.5555977646964, 1433.7132573485344, 1438.3311760031636, 29195.562066568593, 29547.55678664865, 32134.67865321317, 34349.736775006335, 34456.0, 51866.740666297934, 52483.73758131338, 52495.73752131215, 52565.211521827965, 52570.73714631402, 295119.0, 296463.0, 297255.0, 297504.0, 297527.0, 43875.341869871336, 43960.560394396925, 44615.77692111519, 44686.55313446954, 44846.77576612096, 47069.52930470651, 47245.0, 47526.52473475359, 47988.520114798404, 48211.75894120507, 38852.0, 39320.21359572735, 39354.2129157421, 39559.60440395674, 40073.19853602853, 38972.6102738969, 39221.60778392294, 39905.0, 40014.1997160061, 40372.1925561493, 38452.0, 38493.0, 38613.0, 38632.42051369288, 42015.15969680528, 33975.490367645, 38400.0, 38457.807710961264, 39184.80407597944, 39232.607673922896, 26195.73804261933, 26231.0, 26390.208293751217, 26581.468370632865, 26851.194464166107], "unit": "ms", "name": "ext.html", "value": 19703.18439441682}, {"lowerIsBetter": false, "replicates": [343.13701041879676, 345.69924165975607, 361.4776647744009, 363.1755914075051, 368.29839156407036, 14306.213158276316, 14350.784738228935, 16599.41902033429, 17239.224234909427, 18473.90763046186, 15063.397464101423, 15447.536573902773, 15502.224888755545, 15834.683306333867, 17130.05784681845, 5161.458046905077, 5288.894222115556, 5299.470052994709, 5302.178162384817, 5303.045451818671, 3862.594427585105, 3965.2267807777494, 5248.580113590922, 5294.205869119624, 5722.542196624281, 5764.827055188351, 5766.826995190151, 5814.447627475383, 5816.621919575236, 5820.039693450575, 5375.220593013991, 5387.622866399353, 5391.460853914617, 5478.315210598676, 5790.04464263396, 5126.051680439131, 5211.609129315279, 5212.087884620177, 5212.192110222922, 5213.3743950725775, 20105.0, 20590.485237869023, 20651.27720529774, 20769.8961505193, 20914.790852091588, 2056.23919149914, 2108.093519786491, 2144.8820314882673, 2177.412098733333, 2271.7955384015518, 13005.479780808757, 13097.0, 13237.271950042743, 13312.400941957636, 13573.52492662752, 1796.2096677462005, 1839.4297767691924, 1860.0141924779753, 1881.0218686283056, 1892.4417296897311, 59830.40169598335, 60519.0, 61007.694961525354, 61280.0, 62339.37660623426, 9493.857592136124, 9903.0, 9905.356151850106, 9975.60097596088, 9987.900120998842, 12812.487500500061, 12876.678083047811, 12893.677658058436, 12898.742025159632, 12909.806352904714, 7548.622568871535, 7560.659770310349, 7638.694452221849, 7654.770356889302, 7669.923300766921, 6786.660666966632, 6839.384455399038, 6843.110395648633, 6860.0, 7323.780286591411, 5886.087656413263, 5978.282606087298, 5989.940100598938, 6009.609375390585, 6012.016074483791, 1658.5701946648219, 1726.4389073551147, 1746.1007581095746, 1780.6883795336023, 1816.373351193836, 876.6975393489236, 914.4284821986258, 936.8688383626162, 956.297121615612, 1079.6653037558383, 16906.830931690525, 17167.828321716624, 17371.131443428032, 17472.475825725247, 17488.30046798114, 876.5748611923212, 978.2760757039739, 982.4940155819759, 983.4935008470643, 988.3180605382263, 6386.84032899172, 6717.193936727624, 6805.319468053254, 6808.523403361717, 9446.574904129331, 540724.0, 541493.0, 549680.0, 555168.0, 560330.0, 76122.0, 77025.0, 77738.22261777309, 78052.60973695209, 78556.21443785488, 582.033823852403, 586.0184191479341, 586.5776640818603, 587.7413937867325, 588.8910551547891, 10669.933006699268, 11089.5564177432, 11140.721481963015, 11359.375234362189, 11518.654440366803, 31710.682893171695, 31982.200444989063, 32647.673523264464, 34027.65972340245, 35653.82173089118, 44948.0, 45077.54922450865, 46524.0, 46778.76610616925, 47447.76276118597, 6735.595864248161, 6898.620575868375, 6917.7232910685025, 6931.341522555551, 7002.124734408199, 12319.384030798245, 12567.560135395583, 12709.491620335082, 12744.299063551223, 12820.29488378111, 10656.0, 10716.678499645022, 10757.731056723644, 11071.944640276746, 11132.443377831238, 10653.786924261627, 10969.286996345212, 11017.944910275397, 11114.166437517057, 11246.718832029264, 9034.638614455349, 9291.76770580741, 10330.121939634915, 10484.0, 11344.716382090513, 6737.3599508046655, 6764.93235067643, 6808.28513006147, 6838.589684618939, 6855.177378714586, 10754.193435492525, 10819.1344692426, 10864.565417383215, 11009.724756881142, 11074.667759967213], "unit": "ms", "name": "jquery.html", "value": 8166.345151652167}, {"lowerIsBetter": false, "replicates": [1354.2145555577765, 1459.1463993563764, 1520.3310543360924, 1663.6922169398663, 1805.2327760701698, 6664.333566643333, 6728.293529179439, 7177.3899218566485, 7507.136679281884, 7525.51084179528, 7296.598687072209, 7435.144958329794, 7445.962770186142, 7455.813604659873, 7456.366208872252, 1969.350114462224, 2003.6193123306525, 2195.802377785999, 2268.1381075191402, 2308.0998410619786, 2295.6326987681973, 2303.1017903017837, 2303.8041766449874, 2307.7230732312146, 2311.0986715181007, 2221.8777967211795, 2292.4498120451053, 2295.2769877488536, 2295.2999335202758, 2297.655351697242, 1978.8021197880241, 2024.6760518317071, 2181.803637672609, 2234.4190510467397, 2237.015713086253, 2279.7150356205475, 2288.3363824491043, 2309.884505774721, 2319.489712263299, 2334.3113781434517, 7532.284432978859, 7586.165521792598, 7594.810129746746, 7600.657970391346, 7603.695852165907, 4519.163954668397, 4575.039241759235, 4577.3362862384765, 4595.931061034087, 4610.976945115253, 3098.2254436390904, 3100.1784527100335, 3147.35479226758, 3210.4542227821325, 3286.8356582171036, 1163.365965548778, 1937.8740381875275, 1941.0876887862682, 1944.3777991042873, 1951.5999220159833, 10169.59321627134, 10233.027862353065, 10237.692869213935, 10242.385456872611, 10274.33216840903, 4143.150654115899, 4167.874963751093, 4251.936220956688, 4256.0, 4260.8508702195895, 8419.705310314232, 8433.28317093054, 8440.366972476966, 8440.831183376298, 8446.282066024456, 4674.298855171752, 4680.882977925579, 4701.942063035858, 4711.269753188261, 4711.552402521755, 4289.978550107229, 4290.377895205178, 4322.438083049246, 4331.263685173528, 4335.631471324973, 3358.44585643371, 3390.6439823818637, 3413.2832105258176, 3440.9827950860586, 3441.690247877703, 1034.4103860799423, 1044.738815296176, 1049.8897615750388, 1059.3855563772993, 1088.4938503595865, 1032.2722480651123, 1041.7760181561, 1103.365564800227, 1114.6934592986831, 1120.6806060272784, 7167.964160179165, 7194.100737407824, 7207.639618019078, 7233.819154521179, 7235.8552828944175, 1209.8427204463364, 1223.6465463596764, 1236.6228300368473, 1249.5446447730071, 1263.6019653809205, 5510.476504732044, 5691.203231547586, 5725.5133313667975, 5752.683602401824, 5765.135229715493, 8982.236509896602, 9023.593938272663, 9052.140046695553, 9118.95440522793, 9134.360594758304, 8867.556622168866, 8917.242034427016, 9048.366614336934, 9059.59231834569, 9072.183503484717, 6989.545679530815, 7073.717051317993, 7154.570725756471, 7156.212816590275, 7157.785266442015, 6588.703508342041, 6796.524243302922, 6819.624920629214, 6826.146731658543, 6856.24581296047, 7839.05931288249, 8002.239787220205, 8017.8396432072195, 8064.8790268147195, 8065.233802788725, 8036.879446808186, 8091.83816323682, 8155.714549990722, 8248.092709802037, 8258.669653213805, 6309.4952403806665, 6359.07793369968, 6370.872582548416, 6372.58578192416, 6374.681265936777, 7249.275072492919, 7257.383122434441, 7293.708251670086, 7303.525270857377, 7305.671244794104, 6727.798166055026, 6762.6280554568, 6812.82967925786, 6875.862482750217, 6931.410830079298, 6072.514198863992, 6363.395477429637, 6774.085498457645, 6810.965945170243, 6893.93106068953, 6838.3161683833205, 6848.0, 6853.657317134223, 6867.3476019778045, 6874.0, 6305.337939516468, 6312.652804095819, 6316.178896743394, 6323.588966717332, 6343.9682801585695, 6433.099366088658, 6457.6771161442675, 6460.773872914426, 6465.288818229897, 6466.547341686037], "unit": "ms", "name": "mootools.html", "value": 4435.856795463579}, {"lowerIsBetter": false, "replicates": [342.7566427836236, 347.27419692841937, 349.81984278096786, 350.0391425536898, 351.5939090350646, 6010.308814486335, 6093.086037094438, 6094.329623741385, 6120.938790612098, 6145.846353841156, 5962.25471816023, 6018.488428483573, 6027.547933904963, 6040.909386359208, 6051.7276722547485, 4608.5621865922685, 4659.720416774988, 4698.7415692137, 4705.388299521058, 4711.740854253015, 4680.204365257898, 4682.41469816273, 4692.741899195543, 4692.991006933508, 4698.295255711653, 4623.491415944261, 4630.0739852029565, 4639.5360463953675, 4645.233536466479, 4656.185167595674, 4397.186520493703, 4488.079943611552, 4566.20091483989, 4645.094206629708, 4659.743714095724, 4096.856610018635, 4103.261412945669, 4120.423140760296, 4121.62905338521, 4129.69027322952, 5500.1749737539285, 5687.914681279784, 5714.628549144334, 5731.713414329267, 5740.1102829061565, 5224.138017227153, 5299.947000529984, 5421.9457805421835, 5450.209719590677, 5456.7544460499375, 6373.490120790326, 6408.0, 6419.51853610981, 6425.421712045938, 6425.742970281183, 4558.270676691746, 4558.58972692456, 4560.270356742938, 4564.6348292136545, 4566.49768525462, 6459.61242325462, 6637.303083176245, 6642.236142843586, 6646.102776125258, 6659.167604049494, 4532.501424843331, 4532.773361331921, 4562.292844609091, 4567.1550763108935, 4577.725336479755, 4627.542324167876, 4631.930521042187, 4632.745199014086, 4635.58279754817, 4644.86065418038, 5240.68555886648, 5338.252644629755, 5346.705931173823, 5349.22436246742, 5352.9732351338, 6454.677266136769, 6455.548111632141, 6457.2574153971955, 6459.741610335534, 6461.127747753993, 1602.1268408717276, 1602.4631748364195, 1603.5189443167003, 1603.6151323682232, 1604.302128574074, 1063.0804354233533, 1067.556963860005, 1080.8162612355918, 1081.2809481694585, 1085.099367524968, 6203.2556093268195, 6204.069389591597, 6209.844753881189, 6210.9068363974575, 6213.409726076015, 6601.108850305243, 6601.70292336846, 6613.735450582019, 6620.801375958729, 6622.304658010936, 6057.303410107806, 6203.503719702413, 6207.099970504251, 6211.254649442096, 6212.596181248205, 3571.4464258040043, 3581.982090089533, 3589.066842620937, 3591.245838373971, 3598.8200589970397, 6835.453163746988, 6837.3162683731225, 6842.7605033824575, 6845.383915447634, 6848.0, 6637.6349300788925, 6722.655468906239, 6743.1908171019795, 6803.0, 6872.725090996404, 6875.0718652982205, 6884.724611015503, 6892.310768923067, 6933.861322773617, 6935.167779866449, 6651.800445986628, 6652.334766523309, 6661.16735408074, 6665.166854143232, 6668.733250669919, 6455.677216139268, 6587.703553340016, 6610.10763546915, 6614.0, 6615.536912416084, 6857.828554286183, 6900.861982760417, 6903.102596662603, 6903.551269167488, 6908.827279318058, 4527.0, 4550.294704320836, 4555.906582420129, 4557.225271703752, 4571.6799824012, 6475.902861456988, 6631.270560238467, 6632.270450250565, 6636.236832764101, 6636.634985075674, 6486.513511486563, 6488.772892948724, 6490.870182596227, 6493.220813502221, 6494.837629059311, 6466.676666166579, 6471.126397936218, 6472.35276472349, 6476.838079048061, 6476.967615162082, 6226.719797609027, 6357.8728425432155, 6358.109864619049, 6359.20509936258, 6375.298717141203, 6514.57655252407, 6518.120053792677, 6519.250286217146, 6523.967380163069, 6525.575837570543, 6365.8726825464155, 6369.044643303541, 6373.840653983688, 6377.0, 6377.426031657174], "unit": "ms", "name": "prototype.html", "value": 4860.245126410331}, {"lowerIsBetter": false, "replicates": [813.9987814987561, 859.7850537365658, 863.248973393148, 875.6103533927405, 891.9687810926616, 13719.588412347633, 13908.582742517716, 13986.02097853152, 13990.16059036456, 14000.719985600295, 12535.373231338443, 13690.657733556665, 13695.0, 13698.863011369884, 13705.862941370584, 695.0894328429748, 703.2826516952705, 811.7686459359069, 824.7154731617583, 826.2728798657173, 833.0960907415462, 838.2958315015386, 841.2554888923316, 846.0312941681801, 846.3863698818338, 863.6070587882498, 874.8643960186181, 875.8029443375221, 876.5091548732698, 877.8156587116713, 716.8673795347877, 723.2875617516742, 843.363260738145, 854.175720429782, 864.4683519635441, 634.6667999300404, 636.6689321552813, 636.7994081864198, 638.0397501759868, 638.533870274702, 13756.587302380945, 13906.860931390658, 13909.374078166507, 13916.165030098125, 13937.790933136012, 11951.462184201731, 12100.273983561014, 12465.688357791038, 12469.376531173404, 12554.81167782484, 10471.79056418875, 10551.841722374094, 10629.84055239172, 10780.892191078146, 10850.45747712619, 3602.0, 3631.6368363163474, 3668.6514781095752, 3676.613955534657, 3739.4951681522916, 47041.0, 48200.51799482031, 48492.51507484915, 48495.27257091147, 48636.27045594319, 10225.59097636101, 10239.48802559869, 10465.47672616366, 10565.9471702641, 10749.83875241872, 18899.338523151622, 18913.527161821065, 18948.62102757937, 18960.43118706441, 19011.80988190128, 7653.655585498666, 7664.770056898302, 7671.6164191790185, 7750.534967901944, 7863.29230369258, 4238.682098842599, 4359.411479450297, 4359.694821362537, 4385.364122202327, 4406.779661017001, 3119.4852849279614, 3121.719045285935, 3125.9062228133193, 3159.5892533970436, 3159.9684003160132, 454.0578300027456, 462.5536357415111, 465.690315939903, 483.24372357260773, 488.00447087940915, 626.7837596029362, 680.8365992161846, 698.41333280045, 710.9786706398817, 712.8609921065342, 8444.873326900102, 8688.304935605136, 8843.734687959372, 8918.464892106495, 8948.10518948113, 546.5354448718557, 570.6091327440716, 572.7794799002414, 576.4120596991129, 580.3529065092391, 3997.9000524986527, 4139.606737359946, 4203.852865149705, 4381.561843815657, 4478.619317357996, 56222.0, 56950.0, 61074.69462652658, 61128.38871611227, 61477.38522614806, 48933.266001010015, 49114.754426228355, 49342.50657493451, 49670.25494617584, 49781.0, 46287.0, 47760.0, 49104.7544762281, 49552.75223623931, 50153.74923125361, 8840.115988401109, 8928.598213080297, 9367.030829835505, 9444.622215111318, 9487.620495180116, 34669.47995780015, 34969.99999999898, 35644.28711425809, 35942.8202858984, 36201.45697814588, 43424.0, 45160.0, 47639.28541071817, 47912.0, 48223.51776482331, 8261.17388261193, 8408.201220884006, 8493.278071364004, 8756.38705290649, 8824.382293239412, 12356.938215308866, 12583.685407864876, 12676.23942563449, 12766.29785361814, 12864.742705145658, 11126.332420054823, 11250.437478126225, 11293.0, 11685.415729213675, 12061.396930153282, 11739.706507337385, 11834.408279585814, 12007.399630018639, 12121.757564848478, 12553.121281510206, 11523.366214857928, 11768.35274059935, 12008.279503229835, 12214.328211948072, 12292.078094142797, 9952.900470995197, 10032.498375081363, 10106.01199609426, 10181.694549163536, 10525.9473702631, 8847.42491738035, 9609.279304052085, 9617.855732164164, 9690.0, 9725.297743730844], "unit": "ms", "name": "yui.html", "value": 6352.977386880854}], "name": "dromaeo_css", "value": 7017.415381008887}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 109.0, 109.0, 117.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 152.0, 169.0, 124.0, 146.0, 157.0, 126.0, 159.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 159.0, 159.0, 164.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 85.0, 91.0, 73.0, 71.0, 72.0, 96.0, 88.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 131.0, 90.0, 91.0, 90.0, 136.0, 89.0, 90.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 58.0, 58.0, 58.0, 58.0, 58.0, 65.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 93.0, 92.0, 87.0, 85.0, 86.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 126.0, 112.0, 119.0, 118.0, 126.0, 115.0, 124.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [146.0, 150.0, 150.0, 155.0, 152.0, 140.0, 149.0, 150.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 69.0, 70.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1497.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.66250632484397], "unit": "score", "name": "Richards", "value": 209.30555800000002}, {"lowerIsBetter": false, "replicates": [189.0359168241966], "unit": "score", "name": "DeltaBlue", "value": 349.7642200000001}, {"lowerIsBetter": false, "replicates": [282.7254735651682], "unit": "score", "name": "Encrypt", "value": 941.4821969999996}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [27540.54054054054], "unit": "score", "name": "RegExp", "value": 33.07796368989208}, {"lowerIsBetter": false, "replicates": [1335.1134846461948], "unit": "score", "name": "Splay", "value": 61.03675900000002}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 18198.00733074897}]} 07:12:34 INFO - RETURN: dromaeo_css: 7017.42 07:12:34 INFO - RETURN: kraken: 1497.60 07:12:34 INFO - RETURN: v8_7: 18198.01 07:12:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18198.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1497.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7017.42"}}} 07:12:34 INFO - Return code: 0 07:12:34 INFO - # TBPL SUCCESS # 07:12:34 INFO - Running post-action listener: _resource_record_post_action 07:12:34 INFO - Running post-run listener: _resource_record_post_run 07:12:35 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 10354688; Write bytes: 400052224; Read time: 2692; Write time: 261044 07:12:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 585728; Read time: 0; Write time: 48 07:12:35 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8200192; Write bytes: 399466496; Read time: 2612; Write time: 260996 07:12:35 INFO - Running post-run listener: _upload_blobber_files 07:12:35 INFO - Blob upload gear active. 07:12:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:12:35 INFO - Copying logs to upload dir... 07:12:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1286.335465 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 07:12:35.060346) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:35.064196) ========= 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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009874 build_url: 'https://queue.taskcluster.net/v1/task/RLIVoSLkTIasmzBN54ZPNg/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-19 07:12:35.116960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:35.117326) ========= 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=919420d7ee4ef147bef0346300000385-1447931789.996118-1354285073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:12:35.166764) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:12:35.167164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:12:35.167528) ========= ========= Total master_lag: 0.19 =========