builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1448021105.41 results: success (0) buildid: 20151120023014 builduid: 33e0591bbada4cafb5cd9b25d7a11734 revision: c1bac7e467ed12be20caf4a58a7bac4cdf252119 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.413292) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.413742) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.414040) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007527 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.435492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.435802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.449473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.449855) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.498162) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.498441) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.498808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.499100) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 04:05:06-- 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% 42.8M=0s 2015-11-20 04:05:06 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.685866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.686143) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:05.735224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 04:05:05.735547) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1bac7e467ed12be20caf4a58a7bac4cdf252119 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c1bac7e467ed12be20caf4a58a7bac4cdf252119 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 04:05:06,466 truncating revision to first 12 chars 2015-11-20 04:05:06,466 Setting DEBUG logging. 2015-11-20 04:05:06,466 attempt 1/10 2015-11-20 04:05:06,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1bac7e467ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 04:05:07,176 unpacking tar archive at: fx-team-c1bac7e467ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.003341 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 04:05:06.752831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:06.753137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:06.762903) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:06.763238) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 04:05:06.763813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 04:05:06.764101) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:07 INFO - MultiFileLogger online at 20151120 04:05:07 in /builds/slave/test-pgo 04:05:07 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 04:05:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:05:07 INFO - {'append_to_log': False, 04:05:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:05:07 INFO - 'blob_upload_branch': 'Fx-Team', 04:05:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:05:07 INFO - 'branch': 'Fx-Team', 04:05:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:07 INFO - 'config_files': ('talos/linux_config.py',), 04:05:07 INFO - 'default_actions': ('clobber', 04:05:07 INFO - 'read-buildbot-config', 04:05:07 INFO - 'download-and-extract', 04:05:07 INFO - 'populate-webroot', 04:05:07 INFO - 'create-virtualenv', 04:05:07 INFO - 'install', 04:05:07 INFO - 'run-tests'), 04:05:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:07 INFO - 'download_minidump_stackwalk': True, 04:05:07 INFO - 'download_symbols': 'ondemand', 04:05:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:07 INFO - 'installer_path': 'installer.exe', 04:05:07 INFO - 'log_level': 'info', 04:05:07 INFO - 'log_name': 'talos', 04:05:07 INFO - 'log_to_console': True, 04:05:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:07 INFO - 'opt_config_files': (), 04:05:07 INFO - 'pip_index': False, 04:05:07 INFO - 'sps_profile': False, 04:05:07 INFO - 'sps_profile_interval': 0, 04:05:07 INFO - 'suite': 'dromaeojs', 04:05:07 INFO - 'system_bits': '64', 04:05:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:07 INFO - 'title': 'talos-linux64-ix-010', 04:05:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:07 INFO - 'use_talos_json': True, 04:05:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:05:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:07 INFO - 'work_dir': 'build'} 04:05:07 INFO - ##### 04:05:07 INFO - ##### Running clobber step. 04:05:07 INFO - ##### 04:05:07 INFO - Running pre-action listener: _resource_record_pre_action 04:05:07 INFO - Running main action method: clobber 04:05:07 INFO - rmtree: /builds/slave/test-pgo/build 04:05:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:05:08 INFO - Running post-action listener: _resource_record_post_action 04:05:08 INFO - ##### 04:05:08 INFO - ##### Running read-buildbot-config step. 04:05:08 INFO - ##### 04:05:08 INFO - Running pre-action listener: _resource_record_pre_action 04:05:08 INFO - Running main action method: read_buildbot_config 04:05:08 INFO - Using buildbot properties: 04:05:08 INFO - { 04:05:08 INFO - "properties": { 04:05:08 INFO - "buildnumber": 333, 04:05:08 INFO - "product": "firefox", 04:05:08 INFO - "script_repo_revision": "production", 04:05:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:05:08 INFO - "repository": "", 04:05:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:05:08 INFO - "buildid": "20151120023014", 04:05:08 INFO - "slavename": "talos-linux64-ix-010", 04:05:08 INFO - "pgo_build": "True", 04:05:08 INFO - "basedir": "/builds/slave/test-pgo", 04:05:08 INFO - "project": "", 04:05:08 INFO - "platform": "ubuntu64_hw", 04:05:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:08 INFO - "slavebuilddir": "test", 04:05:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:05:08 INFO - "branch": "fx-team", 04:05:08 INFO - "repo_path": "integration/fx-team", 04:05:08 INFO - "stage_platform": "linux64-pgo", 04:05:08 INFO - "builduid": "33e0591bbada4cafb5cd9b25d7a11734", 04:05:08 INFO - "revision": "c1bac7e467ed12be20caf4a58a7bac4cdf252119" 04:05:08 INFO - }, 04:05:08 INFO - "sourcestamp": { 04:05:08 INFO - "repository": "", 04:05:08 INFO - "hasPatch": false, 04:05:08 INFO - "project": "", 04:05:08 INFO - "branch": "fx-team-linux64-pgo-talos", 04:05:08 INFO - "changes": [ 04:05:08 INFO - { 04:05:08 INFO - "category": null, 04:05:08 INFO - "files": [ 04:05:08 INFO - { 04:05:08 INFO - "url": null, 04:05:08 INFO - "name": "https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:05:08 INFO - } 04:05:08 INFO - ], 04:05:08 INFO - "repository": "", 04:05:08 INFO - "rev": "c1bac7e467ed12be20caf4a58a7bac4cdf252119", 04:05:08 INFO - "who": "sendchange", 04:05:08 INFO - "when": 1448020942, 04:05:08 INFO - "number": 6688095, 04:05:08 INFO - "comments": "", 04:05:08 INFO - "project": "", 04:05:08 INFO - "at": "Fri 20 Nov 2015 04:02:22", 04:05:08 INFO - "branch": "fx-team-linux64-pgo-talos", 04:05:08 INFO - "revlink": "", 04:05:08 INFO - "properties": [ 04:05:08 INFO - [ 04:05:08 INFO - "buildid", 04:05:08 INFO - "20151120023014", 04:05:08 INFO - "Change" 04:05:08 INFO - ], 04:05:08 INFO - [ 04:05:08 INFO - "builduid", 04:05:08 INFO - "33e0591bbada4cafb5cd9b25d7a11734", 04:05:08 INFO - "Change" 04:05:08 INFO - ], 04:05:08 INFO - [ 04:05:08 INFO - "pgo_build", 04:05:08 INFO - "True", 04:05:08 INFO - "Change" 04:05:08 INFO - ] 04:05:08 INFO - ], 04:05:08 INFO - "revision": "c1bac7e467ed12be20caf4a58a7bac4cdf252119" 04:05:08 INFO - } 04:05:08 INFO - ], 04:05:08 INFO - "revision": "c1bac7e467ed12be20caf4a58a7bac4cdf252119" 04:05:08 INFO - } 04:05:08 INFO - } 04:05:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:05:08 INFO - Running post-action listener: _resource_record_post_action 04:05:08 INFO - ##### 04:05:08 INFO - ##### Running download-and-extract step. 04:05:08 INFO - ##### 04:05:08 INFO - Running pre-action listener: _resource_record_pre_action 04:05:08 INFO - Running main action method: download_and_extract 04:05:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:08 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json 04:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json 04:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:05:10 INFO - Downloaded 1302 bytes. 04:05:10 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:05:10 INFO - Using the following test package requirements: 04:05:10 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'jsshell-linux-x86_64.zip'], 04:05:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:10 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:10 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:11 INFO - Downloaded 22523565 bytes. 04:05:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:05:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:05:13 INFO - Return code: 0 04:05:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:13 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:14 INFO - Downloaded 22523565 bytes. 04:05:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:05:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:05:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:05:15 INFO - Return code: 0 04:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:15 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:05:16 INFO - Downloaded 11130997 bytes. 04:05:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:05:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:05:16 INFO - Return code: 0 04:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:16 INFO - https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:05:18 INFO - Downloaded 57350611 bytes. 04:05:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:18 INFO - mkdir: /builds/slave/test-pgo/properties 04:05:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:05:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:05:18 INFO - Contents: 04:05:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:18 INFO - Running post-action listener: _resource_record_post_action 04:05:18 INFO - Running post-action listener: set_extra_try_arguments 04:05:18 INFO - ##### 04:05:18 INFO - ##### Running populate-webroot step. 04:05:18 INFO - ##### 04:05:18 INFO - Running pre-action listener: _resource_record_pre_action 04:05:18 INFO - Running main action method: populate_webroot 04:05:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:05:18 INFO - '../fennec_ids.txt'], 04:05:18 INFO - 'tests': ['tcheck2']}, 04:05:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:18 INFO - '--tppagecycles', 04:05:18 INFO - '7'], 04:05:18 INFO - 'tests': ['tsvgm']}}, 04:05:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'tests': ['damp', 'tps']}, 04:05:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['damp', 'tps']}, 04:05:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:18 INFO - 'other': {'tests': ['a11yr', 04:05:18 INFO - 'ts_paint', 04:05:18 INFO - 'tpaint', 04:05:18 INFO - 'sessionrestore', 04:05:18 INFO - 'sessionrestore_no_auto_restore']}, 04:05:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['a11yr', 04:05:18 INFO - 'ts_paint', 04:05:18 INFO - 'tpaint', 04:05:18 INFO - 'sessionrestore', 04:05:18 INFO - 'sessionrestore_no_auto_restore']}, 04:05:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['a11yr', 04:05:18 INFO - 'ts_paint', 04:05:18 INFO - 'tpaint', 04:05:18 INFO - 'sessionrestore', 04:05:18 INFO - 'sessionrestore_no_auto_restore']}, 04:05:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['a11yr', 04:05:18 INFO - 'ts_paint', 04:05:18 INFO - 'tpaint', 04:05:18 INFO - 'sessionrestore', 04:05:18 INFO - 'sessionrestore_no_auto_restore']}, 04:05:18 INFO - 'other_l64': {'tests': ['a11yr', 04:05:18 INFO - 'ts_paint', 04:05:18 INFO - 'tpaint', 04:05:18 INFO - 'sessionrestore', 04:05:18 INFO - 'sessionrestore_no_auto_restore']}, 04:05:18 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:18 INFO - 'ts_paint', 04:05:18 INFO - 'tpaint', 04:05:18 INFO - 'sessionrestore', 04:05:18 INFO - 'sessionrestore_no_auto_restore']}, 04:05:18 INFO - 'svgr': {'tests': ['tsvgx', 04:05:18 INFO - 'tsvgr_opacity', 04:05:18 INFO - 'tart', 04:05:18 INFO - 'tscrollx', 04:05:18 INFO - 'cart']}, 04:05:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['tsvgx', 04:05:18 INFO - 'tsvgr_opacity', 04:05:18 INFO - 'tart', 04:05:18 INFO - 'tscrollx', 04:05:18 INFO - 'cart']}, 04:05:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'tests': ['tp5o']}, 04:05:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'talos_options': ['--e10s'], 04:05:18 INFO - 'tests': ['tp5o']}, 04:05:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'talos_options': ['--xperf_path', 04:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:18 INFO - 'tests': ['tp5n']}, 04:05:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:18 INFO - 'talos_options': ['--e10s', 04:05:18 INFO - '--xperf_path', 04:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:18 INFO - 'tests': ['tp5n']}}, 04:05:18 INFO - 'talos.zip': {'path': '', 04:05:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:18 INFO - Running post-action listener: _resource_record_post_action 04:05:18 INFO - ##### 04:05:18 INFO - ##### Running create-virtualenv step. 04:05:18 INFO - ##### 04:05:18 INFO - Running pre-action listener: _resource_record_pre_action 04:05:18 INFO - Running main action method: create_virtualenv 04:05:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:05:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:05:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:05:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:18 INFO - Using real prefix '/usr' 04:05:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:05:18 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:20 INFO - Installing pip.................done. 04:05:20 INFO - Return code: 0 04:05:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:05: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')]} 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:05:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:05:20 INFO - Using env: {'DISPLAY': ':0', 04:05:20 INFO - 'HOME': '/home/cltbld', 04:05:20 INFO - 'LANG': 'en_US.UTF-8', 04:05:20 INFO - 'LANGUAGE': 'en_US:en', 04:05:20 INFO - 'LOGNAME': 'cltbld', 04:05:20 INFO - 'MAIL': '/var/mail/cltbld', 04:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:20 INFO - 'MOZ_NO_REMOTE': '1', 04:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:20 INFO - 'NO_EM_RESTART': '1', 04:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:20 INFO - 'SHELL': '/bin/bash', 04:05:20 INFO - 'SHLVL': '1', 04:05:20 INFO - 'TERM': 'linux', 04:05:20 INFO - 'TMOUT': '86400', 04:05:20 INFO - 'USER': 'cltbld', 04:05:20 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:20 INFO - '_': '/tools/buildbot/bin/python'} 04:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:05:21 INFO - Cleaning up... 04:05:21 INFO - Return code: 0 04:05:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:05:21 INFO - Using env: {'DISPLAY': ':0', 04:05:21 INFO - 'HOME': '/home/cltbld', 04:05:21 INFO - 'LANG': 'en_US.UTF-8', 04:05:21 INFO - 'LANGUAGE': 'en_US:en', 04:05:21 INFO - 'LOGNAME': 'cltbld', 04:05:21 INFO - 'MAIL': '/var/mail/cltbld', 04:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:21 INFO - 'MOZ_NO_REMOTE': '1', 04:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:21 INFO - 'NO_EM_RESTART': '1', 04:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:21 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:21 INFO - 'SHELL': '/bin/bash', 04:05:21 INFO - 'SHLVL': '1', 04:05:21 INFO - 'TERM': 'linux', 04:05:21 INFO - 'TMOUT': '86400', 04:05:21 INFO - 'USER': 'cltbld', 04:05:21 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:21 INFO - '_': '/tools/buildbot/bin/python'} 04:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:21 INFO - Downloading/unpacking psutil>=0.7.1 04:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:05:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:05:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:23 INFO - Installing collected packages: psutil 04:05:23 INFO - Running setup.py install for psutil 04:05:23 INFO - building 'psutil._psutil_linux' extension 04:05:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:05:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:05:23 INFO - building 'psutil._psutil_posix' extension 04:05:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:05:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:23 INFO - Successfully installed psutil 04:05:23 INFO - Cleaning up... 04:05:23 INFO - Return code: 0 04:05:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:05:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:05:23 INFO - Using env: {'DISPLAY': ':0', 04:05:23 INFO - 'HOME': '/home/cltbld', 04:05:23 INFO - 'LANG': 'en_US.UTF-8', 04:05:23 INFO - 'LANGUAGE': 'en_US:en', 04:05:23 INFO - 'LOGNAME': 'cltbld', 04:05:23 INFO - 'MAIL': '/var/mail/cltbld', 04:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:23 INFO - 'MOZ_NO_REMOTE': '1', 04:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:23 INFO - 'NO_EM_RESTART': '1', 04:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:23 INFO - 'SHELL': '/bin/bash', 04:05:23 INFO - 'SHLVL': '1', 04:05:23 INFO - 'TERM': 'linux', 04:05:23 INFO - 'TMOUT': '86400', 04:05:23 INFO - 'USER': 'cltbld', 04:05:23 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:23 INFO - '_': '/tools/buildbot/bin/python'} 04:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:05:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:05:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:05:25 INFO - Installing collected packages: mozsystemmonitor 04:05:25 INFO - Running setup.py install for mozsystemmonitor 04:05:25 INFO - Successfully installed mozsystemmonitor 04:05:25 INFO - Cleaning up... 04:05:25 INFO - Return code: 0 04:05:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:05:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:05:25 INFO - Using env: {'DISPLAY': ':0', 04:05:25 INFO - 'HOME': '/home/cltbld', 04:05:25 INFO - 'LANG': 'en_US.UTF-8', 04:05:25 INFO - 'LANGUAGE': 'en_US:en', 04:05:25 INFO - 'LOGNAME': 'cltbld', 04:05:25 INFO - 'MAIL': '/var/mail/cltbld', 04:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:25 INFO - 'MOZ_NO_REMOTE': '1', 04:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:25 INFO - 'NO_EM_RESTART': '1', 04:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:25 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:25 INFO - 'SHELL': '/bin/bash', 04:05:25 INFO - 'SHLVL': '1', 04:05:25 INFO - 'TERM': 'linux', 04:05:25 INFO - 'TMOUT': '86400', 04:05:25 INFO - 'USER': 'cltbld', 04:05:25 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:25 INFO - '_': '/tools/buildbot/bin/python'} 04:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:05:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:05:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:05:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:28 INFO - Downloading docopt-0.6.1.tar.gz 04:05:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:05:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:28 INFO - Running setup.py install for blobuploader 04:05:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:05:28 INFO - Running setup.py install for requests 04:05:29 INFO - Running setup.py install for docopt 04:05:29 INFO - Successfully installed blobuploader requests docopt 04:05:29 INFO - Cleaning up... 04:05:29 INFO - Return code: 0 04:05:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:29 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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:05:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:05:29 INFO - Using env: {'DISPLAY': ':0', 04:05:29 INFO - 'HOME': '/home/cltbld', 04:05:29 INFO - 'LANG': 'en_US.UTF-8', 04:05:29 INFO - 'LANGUAGE': 'en_US:en', 04:05:29 INFO - 'LOGNAME': 'cltbld', 04:05:29 INFO - 'MAIL': '/var/mail/cltbld', 04:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:29 INFO - 'MOZ_NO_REMOTE': '1', 04:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:29 INFO - 'NO_EM_RESTART': '1', 04:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:29 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:29 INFO - 'SHELL': '/bin/bash', 04:05:29 INFO - 'SHLVL': '1', 04:05:29 INFO - 'TERM': 'linux', 04:05:29 INFO - 'TMOUT': '86400', 04:05:29 INFO - 'USER': 'cltbld', 04:05:29 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:29 INFO - '_': '/tools/buildbot/bin/python'} 04:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:29 INFO - Running setup.py (path:/tmp/pip-6qepXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:29 INFO - Running setup.py (path:/tmp/pip-r0_76G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:29 INFO - Running setup.py (path:/tmp/pip-IWHkWt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:29 INFO - Running setup.py (path:/tmp/pip-pCpUZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:29 INFO - Running setup.py (path:/tmp/pip-aRyEfJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:29 INFO - Running setup.py (path:/tmp/pip-gBpQgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:29 INFO - Running setup.py (path:/tmp/pip-9BBc1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:29 INFO - Running setup.py (path:/tmp/pip-lHyDBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:29 INFO - Running setup.py (path:/tmp/pip-K51Eio-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:30 INFO - Running setup.py (path:/tmp/pip-gLAF0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:30 INFO - Running setup.py (path:/tmp/pip-mXNJr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:30 INFO - Running setup.py (path:/tmp/pip-tt51OP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:30 INFO - Running setup.py (path:/tmp/pip-IRzN6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:30 INFO - Running setup.py (path:/tmp/pip-G1wsPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:30 INFO - Running setup.py (path:/tmp/pip-vuqCr5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:30 INFO - Running setup.py (path:/tmp/pip-ai2_84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:30 INFO - Running setup.py (path:/tmp/pip-lUwInI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:30 INFO - Running setup.py install for manifestparser 04:05:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:05:30 INFO - Running setup.py install for mozcrash 04:05:30 INFO - Running setup.py install for mozdebug 04:05:30 INFO - Running setup.py install for mozdevice 04:05:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozfile 04:05:31 INFO - Running setup.py install for mozhttpd 04:05:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozinfo 04:05:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozInstall 04:05:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozleak 04:05:31 INFO - Running setup.py install for mozlog 04:05:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for moznetwork 04:05:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozprocess 04:05:31 INFO - Running setup.py install for mozprofile 04:05:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozrunner 04:05:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:05:32 INFO - Running setup.py install for mozscreenshot 04:05:32 INFO - Running setup.py install for moztest 04:05:32 INFO - Running setup.py install for mozversion 04:05:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:05:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:32 INFO - Cleaning up... 04:05:32 INFO - Return code: 0 04:05:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:05:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:05:32 INFO - Using env: {'DISPLAY': ':0', 04:05:32 INFO - 'HOME': '/home/cltbld', 04:05:32 INFO - 'LANG': 'en_US.UTF-8', 04:05:32 INFO - 'LANGUAGE': 'en_US:en', 04:05:32 INFO - 'LOGNAME': 'cltbld', 04:05:32 INFO - 'MAIL': '/var/mail/cltbld', 04:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:32 INFO - 'MOZ_NO_REMOTE': '1', 04:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:32 INFO - 'NO_EM_RESTART': '1', 04:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:32 INFO - 'SHELL': '/bin/bash', 04:05:32 INFO - 'SHLVL': '1', 04:05:32 INFO - 'TERM': 'linux', 04:05:32 INFO - 'TMOUT': '86400', 04:05:32 INFO - 'USER': 'cltbld', 04:05:32 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:32 INFO - '_': '/tools/buildbot/bin/python'} 04:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:32 INFO - Running setup.py (path:/tmp/pip-knR1f7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:32 INFO - Running setup.py (path:/tmp/pip-y3_xT6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:32 INFO - Running setup.py (path:/tmp/pip-pBMu5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:32 INFO - Running setup.py (path:/tmp/pip-JUM2JZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:32 INFO - Running setup.py (path:/tmp/pip-Txh96r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:33 INFO - Running setup.py (path:/tmp/pip-8BrxhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:33 INFO - Running setup.py (path:/tmp/pip-jwLGr7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:33 INFO - Running setup.py (path:/tmp/pip-p3TXsU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:33 INFO - Running setup.py (path:/tmp/pip-12cOYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:33 INFO - Running setup.py (path:/tmp/pip-c76ODd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:33 INFO - Running setup.py (path:/tmp/pip-HAJnF2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:33 INFO - Running setup.py (path:/tmp/pip-5d4axU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:33 INFO - Running setup.py (path:/tmp/pip-Ghu8Bf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:33 INFO - Running setup.py (path:/tmp/pip-oI9jZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:33 INFO - Running setup.py (path:/tmp/pip-EWc9_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:33 INFO - Running setup.py (path:/tmp/pip-rpPGia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:33 INFO - Running setup.py (path:/tmp/pip-WwyhwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:05:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:35 INFO - Downloading blessings-1.5.1.tar.gz 04:05:35 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:35 INFO - Installing collected packages: blessings 04:05:35 INFO - Running setup.py install for blessings 04:05:35 INFO - Successfully installed blessings 04:05:35 INFO - Cleaning up... 04:05:35 INFO - Return code: 0 04:05:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:05:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:36 INFO - Reading from file tmpfile_stdout 04:05:36 INFO - Current package versions: 04:05:36 INFO - argparse == 1.2.1 04:05:36 INFO - blessings == 1.5.1 04:05:36 INFO - blobuploader == 1.2.4 04:05:36 INFO - docopt == 0.6.1 04:05:36 INFO - manifestparser == 1.1 04:05:36 INFO - mozInstall == 1.12 04:05:36 INFO - mozcrash == 0.16 04:05:36 INFO - mozdebug == 0.1 04:05:36 INFO - mozdevice == 0.47 04:05:36 INFO - mozfile == 1.2 04:05:36 INFO - mozhttpd == 0.7 04:05:36 INFO - mozinfo == 0.9 04:05:36 INFO - mozleak == 0.1 04:05:36 INFO - mozlog == 3.0 04:05:36 INFO - moznetwork == 0.27 04:05:36 INFO - mozprocess == 0.22 04:05:36 INFO - mozprofile == 0.27 04:05:36 INFO - mozrunner == 6.11 04:05:36 INFO - mozscreenshot == 0.1 04:05:36 INFO - mozsystemmonitor == 0.0 04:05:36 INFO - moztest == 0.7 04:05:36 INFO - mozversion == 1.4 04:05:36 INFO - psutil == 3.1.1 04:05:36 INFO - requests == 1.2.3 04:05:36 INFO - wsgiref == 0.1.2 04:05:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f296815bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17847c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:05:36 INFO - Using env: {'DISPLAY': ':0', 04:05:36 INFO - 'HOME': '/home/cltbld', 04:05:36 INFO - 'LANG': 'en_US.UTF-8', 04:05:36 INFO - 'LANGUAGE': 'en_US:en', 04:05:36 INFO - 'LOGNAME': 'cltbld', 04:05:36 INFO - 'MAIL': '/var/mail/cltbld', 04:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:36 INFO - 'MOZ_NO_REMOTE': '1', 04:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:36 INFO - 'NO_EM_RESTART': '1', 04:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:36 INFO - 'SHELL': '/bin/bash', 04:05:36 INFO - 'SHLVL': '1', 04:05:36 INFO - 'TERM': 'linux', 04:05:36 INFO - 'TMOUT': '86400', 04:05:36 INFO - 'USER': 'cltbld', 04:05:36 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:36 INFO - '_': '/tools/buildbot/bin/python'} 04:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:05:36 INFO - Cleaning up... 04:05:36 INFO - Return code: 0 04:05:36 INFO - Running post-action listener: _resource_record_post_action 04:05:36 INFO - Running post-action listener: _start_resource_monitoring 04:05:36 INFO - Starting resource monitoring. 04:05:36 INFO - ##### 04:05:36 INFO - ##### Running install step. 04:05:36 INFO - ##### 04:05:36 INFO - Running pre-action listener: _resource_record_pre_action 04:05:36 INFO - Running main action method: install 04:05:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:36 INFO - Reading from file tmpfile_stdout 04:05:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:05:36 INFO - Reading from file tmpfile_stdout 04:05:36 INFO - Output received: 04:05:36 INFO - Usage: mozinstall [options] installer 04:05:36 INFO - Options: 04:05:36 INFO - -h, --help show this help message and exit 04:05:36 INFO - -d DEST, --destination=DEST 04:05:36 INFO - Directory to install application into. [default: 04:05:36 INFO - "/builds/slave/test-pgo"] 04:05:36 INFO - --app=APP Application being installed. [default: firefox] 04:05:36 INFO - mkdir: /builds/slave/test-pgo/build/application 04:05:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:05:51 INFO - Reading from file tmpfile_stdout 04:05:51 INFO - Output received: 04:05:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:05:51 INFO - Running post-action listener: _resource_record_post_action 04:05:51 INFO - ##### 04:05:51 INFO - ##### Running run-tests step. 04:05:51 INFO - ##### 04:05:51 INFO - Running pre-action listener: _resource_record_pre_action 04:05:51 INFO - Running main action method: run_tests 04:05:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:05:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:05:51 INFO - Python 2.7.3 04:05:51 INFO - Return code: 0 04:05:51 INFO - grabbing minidump binary from tooltool 04:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:51 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 0x17c8d70>, '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 0x17c9b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c9fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:05:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:05:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:05:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:51 INFO - Return code: 0 04:05:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:05:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:05:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:05:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:51 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/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:05:51 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/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 04:05:51 INFO - Using env: {'DISPLAY': ':0', 04:05:51 INFO - 'HOME': '/home/cltbld', 04:05:51 INFO - 'LANG': 'en_US.UTF-8', 04:05:51 INFO - 'LANGUAGE': 'en_US:en', 04:05:51 INFO - 'LOGNAME': 'cltbld', 04:05:51 INFO - 'MAIL': '/var/mail/cltbld', 04:05:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:51 INFO - 'MOZ_NO_REMOTE': '1', 04:05:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:51 INFO - 'NO_EM_RESTART': '1', 04:05:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:05:51 INFO - 'SHELL': '/bin/bash', 04:05:51 INFO - 'SHLVL': '1', 04:05:51 INFO - 'TERM': 'linux', 04:05:51 INFO - 'TMOUT': '86400', 04:05:51 INFO - 'USER': 'cltbld', 04:05:51 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960', 04:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:51 INFO - '_': '/tools/buildbot/bin/python'} 04:05:51 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/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 04:05:51 INFO - mozversion INFO | application_buildid: 20151120023014 04:05:51 INFO - mozversion INFO | application_changeset: c1bac7e467ed12be20caf4a58a7bac4cdf252119 04:05:51 INFO - mozversion INFO | application_display_name: Nightly 04:05:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:51 INFO - mozversion INFO | application_name: Firefox 04:05:51 INFO - mozversion INFO | application_remotingname: firefox 04:05:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:05:51 INFO - mozversion INFO | application_vendor: Mozilla 04:05:51 INFO - mozversion INFO | application_version: 45.0a1 04:05:51 INFO - mozversion INFO | platform_buildid: 20151120023014 04:05:51 INFO - mozversion INFO | platform_changeset: c1bac7e467ed12be20caf4a58a7bac4cdf252119 04:05:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:05:51 INFO - mozversion INFO | platform_version: 45.0a1 04:05:51 INFO - 2015-11-20 04:05:51,339 DEBUG : using testdate: 1448021151 04:05:51 INFO - 2015-11-20 04:05:51,339 DEBUG : actual date: 1448021151 04:05:51 INFO - 2015-11-20 04:05:51,391 INFO : starting webserver on 'localhost:53266' 04:05:51 INFO - 2015-11-20 04:05:51,392 INFO : Starting test suite talos-linux64-ix-010 04:05:51 INFO - 2015-11-20 04:05:51,392 INFO : Starting test dromaeo_css 04:05:51 INFO - 2015-11-20 04:05:51,392 DEBUG : operating with platform_type : linux_ 04:05:51 INFO - 2015-11-20 04:05:51,393 INFO : Initialising browser for dromaeo_css test... 04:05:51 INFO - 2015-11-20 04:05:51,409 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptR7PMF/profile http://localhost:53266/getInfo.html 04:05:55 INFO - 2015-11-20 04:05:55,389 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:55 INFO - 2015-11-20 04:05:55,389 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:55 INFO - 2015-11-20 04:05:55,389 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:05:55 INFO - 2015-11-20 04:05:55,389 DEBUG : BROWSER_OUTPUT: __metrics 04:05:55 INFO - 2015-11-20 04:05:55,450 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:56 INFO - 2015-11-20 04:05:56,728 INFO : Browser initialized. 04:05:56 INFO - 2015-11-20 04:05:56,729 INFO : Running cycle 1/1 for dromaeo_css test... 04:05:56 INFO - 2015-11-20 04:05:56,729 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptR7PMF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:08 INFO - 2015-11-20 04:06:08,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 142508032 04:06:08 INFO - 2015-11-20 04:06:08,493 DEBUG : BROWSER_OUTPUT: 04:06:59 INFO - 2015-11-20 04:06:59,954 DEBUG : BROWSER_OUTPUT: 1448021219950 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:09:08 INFO - 2015-11-20 04:09:08,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53266/tests/dromaeo/cssquery-ext.html) 04:09:09 INFO - 2015-11-20 04:09:09,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 258179072 04:09:09 INFO - 2015-11-20 04:09:09,878 DEBUG : BROWSER_OUTPUT: 04:12:12 INFO - 2015-11-20 04:12:12,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/dromaeo/cssquery-ext.html (next: http://localhost:53266/tests/dromaeo/cssquery-jquery.html) 04:12:12 INFO - 2015-11-20 04:12:12,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 215085056 04:12:12 INFO - 2015-11-20 04:12:12,731 DEBUG : BROWSER_OUTPUT: 04:15:14 INFO - 2015-11-20 04:15:14,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53266/tests/dromaeo/cssquery-mootools.html) 04:15:15 INFO - 2015-11-20 04:15:15,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 210833408 04:15:15 INFO - 2015-11-20 04:15:15,252 DEBUG : BROWSER_OUTPUT: 04:18:17 INFO - 2015-11-20 04:18:17,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53266/tests/dromaeo/cssquery-prototype.html) 04:18:17 INFO - 2015-11-20 04:18:17,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 200658944 04:18:17 INFO - 2015-11-20 04:18:17,756 DEBUG : BROWSER_OUTPUT: 04:21:20 INFO - 2015-11-20 04:21:20,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53266/tests/dromaeo/cssquery-yui.html) 04:21:20 INFO - 2015-11-20 04:21:20,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 202858496 04:21:20 INFO - 2015-11-20 04:21:20,750 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/dromaeo/cssquery-yui.html (next: http://localhost:53266/tests/dromaeo/cssquery-dojo.html) 04:24:23 INFO - 2015-11-20 04:24:23,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 275275776 04:24:23 INFO - 2015-11-20 04:24:23,537 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,539 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:24:23 INFO - 2015-11-20 04:24:23,539 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:24:23 INFO - 2015-11-20 04:24:23,539 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:24:23 INFO - 2015-11-20 04:24:23,539 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:24:23 INFO - 2015-11-20 04:24:23,543 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3171.762117841162;3200.3119329344186;3238.2228265216354;3242.2218667519787;3267.5425440438344;5238.109521381365;5249.265102885594;5310.548603368708;5358.33020872391;5367.597430192732;5276.3668359796875;5282.973585132069;5354.946450535494;5358.732063396825;5405.675659460425;4815.061063092707;4874.829380971667;4943.505649435046;4953.207486802113;5033.043721692867;4820.228763397857;5012.172991456406;5030.748462576875;5055;5111.412187598418;4789.018251258501;4894.388201474816;4900.436449808282;4930.2851086592245;4933.7533123343865;4869.586085182764;4908.705477671316;4920.015996800654;4922.507749225085;4947.307376967227;4704.976475117637;4891.559759621616;4894.559489645913;4899.412070551521;4949.307097006422;5087.618428617831;5188.195829646411;5203.765830537635;5208.869778255536;5236.947630523722;5836.328822185461;5838.036723940545;5850.736716847752;5852.063669812809;5853.560982926298;5625.915611265835;5812.360640329561;5893.351731309553;5893.764249430018;5898.705064746789;5369.81205657804;5442.91835622466;5443.537299329561;5445.863853403696;5496.560275177976;5910.320313164041;5947.672877991752;5974.283086029617;5977.820665380045;5979.850503737442;5534.08687566547;5638.915416268759;5639.887202255932;5769.653820770767;5770.451807078321;5701.230333904869;5768.9711551442815;5805.651660900359;5820.592558520862;5822.068469045017;5735.053716136874;5775.335836378787;5776.913346299809;5828;5828.825135245949;5664.773409063591;5795.565332600072;5804.303483581913;5805.216295800097;5814.186013958049;4396.230659634615;4480.731156130578;4488.573585509372;4491.214037543416;4522.728636281834;3984.4620976168426;3984.7011474139554;3990.18201268745;4004.619561141687;4029.536603290659;5412.431694672082;5413.891722165535;5414.891702166014;5419.160030195326;5479.506844384025;5694.658320500783;5720.885582288331;5818.8254352369495;5824.767009319579;5851.151583020438;5510.393856675762;5534.446555344433;5537.501624853702;5539.14143307788;5541.639793413416;5133.050385678586;5143.562797162208;5160.391903317298;5165.819196328111;5207.765650545734;5791.449812267828;5857.238558987305;5861.325947516005;5926;5962.850928726816;5772.7690892363835;5798.536117110705;5896.646201227769;5899.469047785548;5903.291605007426;6019.638821670714;6054.273487181566;6058.394160583906;6058.909116363347;6059.818205453844;5596.440355964371;5659.603827732019;5725.255716756795;5799.76800927975;5817.127430885401;5761.539076873756;5902.586818922634;5903.822885313448;5904.439078287556;5961.433663801932;5721.628094173865;5743.913841292468;5744.368119506935;5747.339056008613;5752.050911599539;5498.202760599771;5539.639923404966;5598.3282006159525;5700.572457065819;5724.656520608777;5496.890062198813;5544.473275038865;5552.3892371839875;5556.083246264483;5567.081431563909;5707.972564938351;5721.456461636138;5733.02538568436;5735.7705691773535;5738.368779434342;5412.594055445936;5612.85967850807;5624.128260119688;5625.718714064198;5628.0432326505415 04:24:23 INFO - 2015-11-20 04:24:23,544 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.3040968379843;575.0597772641729;590.5098768022542;594.7680404642189;602.5089552015108;30954.690453095463;31751.36497270056;31768.523472147906;39765.80117099418;40598.797006015004;43340.56659433412;43862.78068609653;43939.78030109845;43976.78011609938;44006.55993440065;8710.608022638997;8884.289256859469;8889.111088891124;8894.377393582452;8896.199342059213;7563.357114645261;7833.451658383916;7833.686652533892;10368.844467332996;10624.734381640443;10387.84418233727;10470.057694807465;10488.318259313159;10491.842622360633;10506.894931050707;10464.162866970662;10556.577736890515;10560.947195263974;10561.468587054873;10573.259871808976;7791.571463569501;8025.23760242776;10386.79226415475;10686.839697404468;10700.464976751131;40301;40745.185096298206;40755.184896302206;40800;40816;3086.506159014569;3230.1924518870283;3675.9891029966707;3701.03773019017;3760.417135344026;29980.250493737614;30251;30709.232269193224;30854;31141.221469463217;3943.507061617298;3975.542812576533;3979.5025621797276;4059.9188016239805;4061.248668996245;284670;284692;285929;286162;286608;49637.25544116841;58600;58794;58880;58936.70531647314;52181.217281740806;68134;68636.6568167166;68643.7627484705;68716.31283687199;16047.598810029609;16106.275217615235;16313.510594682179;16317.673646527002;16325.26536305869;12424.37878106091;12480.18878772895;12493.12548121641;12502.499900003899;12519.687007824878;19084;19364.128614212394;19392.90303548473;19411.708824367644;19437.4168774937;7496.362809161174;7696.960910277153;7719.150893401721;7772.396247257232;7816.41376896735;895.9776005599912;959.1032384720309;1012.9594816207417;1106.3343356278326;1111.1166622535104;28590.428191436054;28773.856130719632;28787.75040248793;28942.855285723857;29178.708212918023;1019.3628981886321;1031.376017509411;1048.0829274384914;1075.4676435164642;1108.728361551425;12625;13523.39144738489;13662.385192666354;13756.587302380945;14110.647233819236;336136;342074;342311;342982;343255;51908;52051.47948520466;52059.47940520622;52089.21866172011;52121.7393913028;1352.2562590575144;1364.8225730654951;1372.2041216094642;1374.202962281874;1388.8125103110951;26776;27339.179824605293;27907.720922791323;28039.299017524725;28107.71892281051;42269.577304227794;43640;43933.340999885666;44387.55612443834;44427.555724443635;425766;437088;441843;443756;443885;31808.840955795073;32200.19499512531;32256.838715806272;32258.19354516062;32275.35449291048;42522.36216456694;43060.56939430691;43098.56901431071;43364.78317608392;43998.340024900295;36266.63733362633;36352.81823590865;36398.81800591086;36546;37696.811515943344;34721.479177811845;34874.47688284627;35103.64896351004;35298.64701352954;35380.46929296011;36305.27389452144;38258.8087059574;38963.80518097391;39264.214715704955;39319.80340098281;30738.385232295677;33164.005079847644;33859.4921076189;34095.14762130967;34164.65835341615;25950.740492594832;27169;27227.319317017234;27339.31651708723;27487 04:24:23 INFO - 2015-11-20 04:24:23,545 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.9928604810723;358.38000259550995;359.591863235228;360.3873415194169;363.42034455044194;14169.574912752609;14230.146191228534;16553.420630277942;16843.326266949323;17515.91242043791;11077.169212309089;11363.431828408588;16070.678586428294;17040.488785336427;17119.486415407526;4822.493638168004;4931.605471562267;4936.407631084275;4937.753112344386;4938.160512712848;3572.1962558424407;3682.760620559655;4869.123557759602;4892.046051020035;5285.920711189336;5350.705711185883;5373.543248823855;5382.950324686668;5423.240746295522;5431.049566325897;5212.582993360522;5366.731663416814;5374.91937620936;5420.349558053039;5421.996930567838;4975.776090075955;5114.820981265638;5122.820701275475;5152.845414637567;5172.043172013152;19493.610127797507;19529.707054394195;20015.29946451882;20210;20213.19147234109;1915.9137838797149;1968.2028778344793;2004.4988752811796;2020.666590012646;2041.071312552785;9662.32363734539;9704.90295097047;9986.450745209011;11995.760084798343;12597.496100155982;1821.6174603333316;1922.692369220918;1925.9995033523714;1938.9612207755906;2002.619502294574;60803.39196608021;63358;63967.68016159936;64033.679831600544;64503.354966450206;10171.4914254287;10245.334053286513;10267.075963163352;10283.74290642725;10319.896801032044;13502.932485337707;13526.565218260808;13533.593992180251;13537.323133843269;13540.93229533846;7781.416393770377;7844.725434609875;7845.764627061198;7887.487313324616;7909.881351779728;7701.422393320523;7724.92275077242;7726.536407815549;7760.185180556074;7778.377729781604;4392.978035109804;4454.888627784267;4472.1502914446155;4480.103979204107;4485.945802736354;1679.8908070975347;1734.8698847586481;1788.3115000724815;1809.5928416106271;1862.8323450889486;858.4934888415864;876.4390789894472;889.2086043421231;910.649399981012;958.7603099225194;16122.355105795872;16536.421225257058;16784.580385490215;16880.493585192464;16973.40593079261;814.5764202614607;869.4652788535005;884.1821315283337;894.2443635128307;899.9730008099767;9134.588943497558;9345.392549484262;9348.158665720119;9402.01278865723;9412.435253884789;565961;566102;567925;590918;591414;83018.75471867927;84899.5755021221;85884.57057714672;86258;87528;1114.8272017837248;1138.072470936201;1141.6232643227715;1161.2567956507842;1184.2420850655587;15230.390784368501;15750.527484175493;15785.763213552036;15948.68102637964;16073.517794466185;36283.818580906925;36555.634443655224;36638;36747.63252367549;37084.81457592695;48083.519164807905;48800.75599621979;49844.750776245884;52023.219651706015;54016.45983540114;9033.95483022607;9041.593128309374;9052.3210759192;9142.131497507726;9594.18449431806;17164.22760975734;17519.21163547618;17735.201915914073;17881.19534620919;17922.103894805467;13938.790918136034;14070.296485175495;14314.570562882713;14771.778423323443;14886.330115145061;13907.774756038985;13991.720165596427;14200.147991120566;14368.425262989782;14465.349059292146;11512;12010;12787.680307992374;14601.70796584041;15002.849971500582;9456.19622332082;9466.195373393339;9500.572474238814;9653.46905920181;9653.758656033655;14406.567802965928;14505.347259373142;14933.551993440215;15190.848091518943;15469.381224751334 04:24:23 INFO - 2015-11-20 04:24:23,547 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1357.4434481862438;1719.9398021069262;1731.2555601091533;1777.85777137829;1779.9644007119857;6536.967315163423;6767.627780472072;6925.896111558318;6930.965345173279;6946.235914049451;7087.007818905345;7168.677409516571;7193.89209161863;7194.100737407824;7196.280371962801;1936.8547358948065;1959.4513536209884;1966.4985428715659;2234.162189179062;2258.627326491127;2013.0941076515553;2265.184533567914;2312.560613483433;2313.699219101523;2314;2152.9138834446603;2182.301663467691;2192.3970908000347;2192.4080498265457;2196;1919.4145785535407;1952.3947576251408;2222.1777942161425;2253.2902135827244;2253.3690566641367;2224.455008522922;2269.3986093685185;2270.7615700351557;2272.091163534583;2275.5448910218024;7086.468514861406;7234.5659260444545;7251.383632391253;7261.382782463497;7266.128064632225;4542.863714088583;4604.907901841978;4612.76936153191;4615.169269531483;4657.394538709946;3028.9394212115635;3111.7821752477334;3152;3172.2069482629345;3182.793118447317;1053.6101642392364;1091.6670415523263;1117.3854380090918;1164.7728692904886;1967.7737060238112;9913.851292230622;9972.850407243897;9977.700668979942;9996.050375214343;10005.449700266483;4072.6741860651077;4122.7732474713575;4164.7709375984;4258.169656916872;4293.613574778285;8028.438009339407;8083.434159608889;8083.555404452812;8083.636236369378;8086.9191308086165;4581.679282450196;4597.42532183477;4611.446626404786;4622.422197225347;4626.537346265347;4255.5744425557195;4275.46556680415;4279.507856596469;4281.807318670667;4284.807183676742;3355;3358.009387230773;3367.7979321240805;3399.7110245629397;3405.6594340565744;1009.4700282351824;1014.6398028699705;1016.7051555049101;1022.2077889635592;1023.6161439460202;985.2955137077024;987.8370068938689;997.7356000659831;1110.5113749949996;1298.5195477673133;6653.168353955755;6749.42629876466;6787.6266805325195;6812.420944219797;6814.250432452426;461.7114303560275;469.60553135365774;473.8554740804019;475.55535574237507;478.849162513807;5120.462351453119;5246.422893481714;5334.199870019451;5459.181122831527;5582.637128586629;8675;8912.465252084896;9052.321075919332;9073.13805188506;9130.817383652422;8767.21095101444;8967.730968070968;9059.773505662411;9061.41100828444;9075.183233509017;6666.100076489709;6691.7323307068145;6715.7985260442265;6721.596704197764;6729.798106056826;6612.702428390638;6758.357955994173;6772.492063095189;6778.389944904982;6785.457163427012;7825.452218344889;7999;8101.635426405944;8123.147069557847;8163.183681631789;8123.4313598047565;8175.345972322319;8280.171982801672;8327.333813294801;8394.118617545315;6289.874202516015;6336.334684858023;6354.26925903527;6355.936440635534;6359.459445947146;6819.215790183994;7176.96411517939;7191.101112360955;7213;7227.7831665050135;6700.363465470772;6760.797176084725;6774.898376524455;6842.110525631835;6865.5537390069485;6575.539712220098;6585.80242592723;6659.234188068434;6697.732090716317;6757.391834734897;6650.567713098633;6651.43462805667;6681.198256209286;6686.398224159849;6707.765228216989;6077.179580756718;6235.563510554218;6274.843128921813;6277.15258440123;6280.717367718372;6242.687865606792;6320.367963203643;6334.9366506334345;6336.303006669171;6340.175777149126 04:24:23 INFO - 2015-11-20 04:24:23,547 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.6141675656239;335.17714012100294;337.50386931211125;339.40603943099575;347.99304013919715;6065.757369705212;6076.696165191739;6088.8477788055325;6089.086637004451;6120.54095942805;5802.680852553108;5860.941390586093;5940.88118237635;6024.066269728188;6048.576599638027;4667.1365797327435;4667.393238878941;4677.953220467786;4697.224957881946;4698.2482802751565;4450.065486247891;4680.227762419214;4682.531746825324;4684.063187362541;4690.742009189493;4516.616087632555;4518.164139634178;4591.691367960132;4604.562566556172;4611.077784443108;4555.4533455985165;4579.610733087675;4583.495815460296;4585.220512512864;4587.747673877935;4088.713790034699;4093.099518106012;4093.9181216375805;4094.7338423002707;4103.85636502721;5624.915626265569;5726.169705392695;5731.197632331477;5733.312002559678;5733.799317023884;5371.355437347504;5381;5382.91925621116;5383.650062745948;5387.730613469311;6485.416312531895;6487.124238227826;6490.0589414534625;6494.058361537598;6496.902546461807;4473.821047158142;4482.394876691637;4483;4483.529229430928;4488.035072459437;6617.338266173344;6686.030525573813;6693.2302785179845;6749.93250067498;6757.087793147911;4552.931706024412;4553.612942899825;4555.40779698637;4555.589996900295;4563.977180114144;4605.217113090783;4611.146937816515;4617.284320930261;4619.214733495314;4624.3294722265755;5351.491608297206;5355.250264962909;5355.892882142335;5360.249565060894;5365.195220716846;6351.793159299718;6477.125588045647;6495.447886929569;6497.090407342976;6497.220333560003;1617.24797968945;1621.367666610023;1631.111044480761;1631.7715519827234;1635.215096753565;1073.431081526792;1090.3893819460968;1097.7145942055124;1100.3178029621686;1120.6133883810073;6258.718357673915;6260;6261.530385221126;6266.24805023391;6290.905636415458;6462.192225971754;6688.933110668831;6711.664416779142;6711.664416779239;6715.127033485615;6110.205673262448;6217.316095229521;6304.716287767062;6308.296759874808;6313.55805093639;3583.229605634749;3635.4183330666965;3638.072291565634;3639.6906262967946;3645.0705070206927;6823.420009299166;6983.685734141975;6986.44108471321;6987;6989.0564773755905;6885.657296827171;6906.758263460755;6918.37734603878;6921.965390173118;6941.861162776716;6978;6982.825429364307;6990.510664253555;7002.439804815603;7003.3346832050875;6603.80188594343;6733.124693789972;6733.3939945405145;6741.359570840762;6741.831454213684;6690.765823196165;6691.130153080263;6691.46468282546;6696.430803381572;6697.866042679217;6976.476764242803;6979;6985.860282794417;6991.720331186695;7004.124484439445;4449.955500444954;4552.840650577214;4556.726596404226;4557.316402539513;4560.1335746208115;6698.56459330142;6700.363465470772;6700.396964273239;6711;6711.161104861892;6526.151600291932;6531.967340163459;6533.8693226136165;6534.052562378523;6537;6356.586821856565;6533.575317604341;6534.085228067979;6541.215054193527;6541.280459149585;6420.967895160495;6428.389303016206;6430.871382572229;6431.1317972073175;6431.517636177212;6522.836929076811;6568.408843204134;6568.573042752206;6573.704183311666;6573.967130164318;6300.495960323255;6385.329540398191;6410;6412;6417.518686098468 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.5484709174495;797.3700776386655;808.688654867876;834.9707760228389;864.3171894203577;13336.466541338346;13461.730765384698;13489.595312140627;13510.189388636663;13539.79690304645;13004.154729942547;13286;13390.263535505543;13906.860931390684;13919.721605567882;815.926566609005;832.8375966686499;833.0336809301211;833.7790485521342;833.9207775261341;809.1423091522975;815.4006804998321;818.9262966333029;819.9385046121535;820.1716266570747;852.1776485691306;861.732862812527;863.6027427383411;864.5115509736978;865.1521508921261;857.1428571428571;858.5235194467068;859.5788063848731;859.879616853641;861.0915484164204;624.6064979063207;627.3068259573197;628.6196850905183;629.2071989293478;629.408356145222;12258.938705306417;12340.568080117153;12365.134440589163;12367.257964522158;12382.380880955916;10622;10803.297785643908;11202.775944481065;11232.157588180919;11425.302792907078;8944.373893827435;8999.190072893405;9666.903330966741;9814.312998090136;9929.3545919515;3478.89563313101;3567.161716996504;3578.7315951303494;3652.945205821915;3658.9085272868124;40759.592404076175;40843.38734918978;46630.76684616589;50266;51242.23136652916;8270.917290827136;10343.9482802587;10477.68566942993;10547.156227501782;10610.575576976835;16796;19146.425607231806;19160.137793799313;19191.712124318146;19193.80806191948;7716.807079823049;7830.765077047698;7835.882461763078;7892.131865494791;7899.644515996794;4268.125034367947;4298.4841818981295;4321.135772845443;4353.564643535685;4376.474823021194;2954.246667099919;2961.8815247390294;2982.9850850746043;2987.357718090621;2990.8953186638364;528.4609698107985;535.8097875254307;539.2692901119005;541.5910987204635;547.3951283831389;608.89119529493;665.2349797732646;678.1827897383641;693.445243804954;709.5636183747062;9344.90655093454;9383.296252781069;9480.90519094814;9554.75463266132;9820.753590896362;574.6006525464762;633.9349892181087;669.9765508207189;678.1523096129838;724.6847621284758;4180.26845302077;4322.113966636832;4338.284183109815;4369.650427965818;4499.707519011254;59769.402305976386;61064;61156;61168.38831611627;61194.694026529585;44171.337429938576;53893.461065388845;54244;54535.72732136314;55140.72429637826;43806.56193438089;47215;50556;50646;52243.73878130661;8619.353548484014;8817.206451419403;9191.242627211675;9243.722688319362;9253.120953509406;32140.19649508781;32840.671593284715;35715.64284357227;36366.63633363633;38431;41857.79071104625;41887.371689425294;44514.3322850164;49195.262071068246;49219.753901230266;10902.836457452986;11091.778164436504;11376.715582110513;11419.714507137389;11979.161458697807;12495.93752031234;12621.305828179538;12764.872351276368;12821.102522823312;12906.741865162456;11565.710857228636;11737.706557336134;11882.22765520273;12064.215825971283;12470.189437686522;11294.265872718248;11638.592649257236;11882.049436045269;11961.043116550829;12349.444275007467;11107;11363.715907102389;11711.355875426932;11741.119416044;11816.940915295369;9969.700908972742;10045.748856278651;10246.282760207012;10333.586656533955;10464.895351046393;9073.45559266446;9115.270778337584;9252.398594091363;9559.856602150834;9673.854892176763 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: __startTimestamp1448022263538__endTimestamp 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,548 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:24:23 INFO - 2015-11-20 04:24:23,549 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:24:23 INFO - 2015-11-20 04:24:23,549 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,549 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5385.29 Median:5556.08 stddev:600.27 (10.8%) stddev-sans-first:576.45 04:24:23 INFO - 2015-11-20 04:24:23,549 DEBUG : BROWSER_OUTPUT: Values: 3171.8 3200.3 3238.2 3242.2 3267.5 5238.1 5249.3 5310.5 5358.3 5367.6 5276.4 5283.0 5354.9 5358.7 5405.7 4815.1 4874.8 4943.5 4953.2 5033.0 4820.2 5012.2 5030.7 5055.0 5111.4 4789.0 4894.4 4900.4 4930.3 4933.8 4869.6 4908.7 4920.0 4922.5 4947.3 4705.0 4891.6 4894.6 4899.4 4949.3 5087.6 5188.2 5203.8 5208.9 5236.9 5836.3 5838.0 5850.7 5852.1 5853.6 5625.9 5812.4 5893.4 5893.8 5898.7 5369.8 5442.9 5443.5 5445.9 5496.6 5910.3 5947.7 5974.3 5977.8 5979.9 5534.1 5638.9 5639.9 5769.7 5770.5 5701.2 5769.0 5805.7 5820.6 5822.1 5735.1 5775.3 5776.9 5828.0 5828.8 5664.8 5795.6 5804.3 5805.2 5814.2 4396.2 4480.7 4488.6 4491.2 4522.7 3984.5 3984.7 3990.2 4004.6 4029.5 5412.4 5413.9 5414.9 5419.2 5479.5 5694.7 5720.9 5818.8 5824.8 5851.2 5510.4 5534.4 5537.5 5539.1 5541.6 5133.1 5143.6 5160.4 5165.8 5207.8 5791.4 5857.2 5861.3 5926.0 5962.9 5772.8 5798.5 5896.6 5899.5 5903.3 6019.6 6054.3 6058.4 6058.9 6059.8 5596.4 5659.6 5725.3 5799.8 5817.1 5761.5 5902.6 5903.8 5904.4 5961.4 5721.6 5743.9 5744.4 5747.3 5752.1 5498.2 5539.6 5598.3 5700.6 5724.7 5496.9 5544.5 5552.4 5556.1 5567.1 5708.0 5721.5 5733.0 5735.8 5738.4 5412.6 5612.9 5624.1 5625.7 5628.0 04:24:23 INFO - 2015-11-20 04:24:23,549 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,549 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51799.55 Median:342646.50 stddev:95084.30 (27.7%) stddev-sans-first:95273.19 04:24:23 INFO - 2015-11-20 04:24:23,550 DEBUG : BROWSER_OUTPUT: Values: 552.3 575.1 590.5 594.8 602.5 30954.7 31751.4 31768.5 39765.8 40598.8 43340.6 43862.8 43939.8 43976.8 44006.6 8710.6 8884.3 8889.1 8894.4 8896.2 7563.4 7833.5 7833.7 10368.8 10624.7 10387.8 10470.1 10488.3 10491.8 10506.9 10464.2 10556.6 10560.9 10561.5 10573.3 7791.6 8025.2 10386.8 10686.8 10700.5 40301.0 40745.2 40755.2 40800.0 40816.0 3086.5 3230.2 3676.0 3701.0 3760.4 29980.3 30251.0 30709.2 30854.0 31141.2 3943.5 3975.5 3979.5 4059.9 4061.2 284670.0 284692.0 285929.0 286162.0 286608.0 49637.3 58600.0 58794.0 58880.0 58936.7 52181.2 68134.0 68636.7 68643.8 68716.3 16047.6 16106.3 16313.5 16317.7 16325.3 12424.4 12480.2 12493.1 12502.5 12519.7 19084.0 19364.1 19392.9 19411.7 19437.4 7496.4 7697.0 7719.2 7772.4 7816.4 896.0 959.1 1013.0 1106.3 1111.1 28590.4 28773.9 28787.8 28942.9 29178.7 1019.4 1031.4 1048.1 1075.5 1108.7 12625.0 13523.4 13662.4 13756.6 14110.6 336136.0 342074.0 342311.0 342982.0 343255.0 51908.0 52051.5 52059.5 52089.2 52121.7 1352.3 1364.8 1372.2 1374.2 1388.8 26776.0 27339.2 27907.7 28039.3 28107.7 42269.6 43640.0 43933.3 44387.6 44427.6 425766.0 437088.0 441843.0 443756.0 443885.0 31808.8 32200.2 32256.8 32258.2 32275.4 42522.4 43060.6 43098.6 43364.8 43998.3 36266.6 36352.8 36398.8 36546.0 37696.8 34721.5 34874.5 35103.6 35298.6 35380.5 36305.3 38258.8 38963.8 39264.2 39319.8 30738.4 33164.0 33859.5 34095.1 34164.7 25950.7 27169.0 27227.3 27339.3 27487.0 04:24:23 INFO - 2015-11-20 04:24:23,550 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,550 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30178.31 Median:36692.82 stddev:94302.26 (257.0%) stddev-sans-first:94540.22 04:24:23 INFO - 2015-11-20 04:24:23,550 DEBUG : BROWSER_OUTPUT: Values: 354.0 358.4 359.6 360.4 363.4 14169.6 14230.1 16553.4 16843.3 17515.9 11077.2 11363.4 16070.7 17040.5 17119.5 4822.5 4931.6 4936.4 4937.8 4938.2 3572.2 3682.8 4869.1 4892.0 5285.9 5350.7 5373.5 5383.0 5423.2 5431.0 5212.6 5366.7 5374.9 5420.3 5422.0 4975.8 5114.8 5122.8 5152.8 5172.0 19493.6 19529.7 20015.3 20210.0 20213.2 1915.9 1968.2 2004.5 2020.7 2041.1 9662.3 9704.9 9986.5 11995.8 12597.5 1821.6 1922.7 1926.0 1939.0 2002.6 60803.4 63358.0 63967.7 64033.7 64503.4 10171.5 10245.3 10267.1 10283.7 10319.9 13502.9 13526.6 13533.6 13537.3 13540.9 7781.4 7844.7 7845.8 7887.5 7909.9 7701.4 7724.9 7726.5 7760.2 7778.4 4393.0 4454.9 4472.2 4480.1 4485.9 1679.9 1734.9 1788.3 1809.6 1862.8 858.5 876.4 889.2 910.6 958.8 16122.4 16536.4 16784.6 16880.5 16973.4 814.6 869.5 884.2 894.2 900.0 9134.6 9345.4 9348.2 9402.0 9412.4 565961.0 566102.0 567925.0 590918.0 591414.0 83018.8 84899.6 85884.6 86258.0 87528.0 1114.8 1138.1 1141.6 1161.3 1184.2 15230.4 15750.5 15785.8 15948.7 16073.5 36283.8 36555.6 36638.0 36747.6 37084.8 48083.5 48800.8 49844.8 52023.2 54016.5 9034.0 9041.6 9052.3 9142.1 9594.2 17164.2 17519.2 17735.2 17881.2 17922.1 13938.8 14070.3 14314.6 14771.8 14886.3 13907.8 13991.7 14200.1 14368.4 14465.3 11512.0 12010.0 12787.7 14601.7 15002.8 9456.2 9466.2 9500.6 9653.5 9653.8 14406.6 14505.3 14933.6 15190.8 15469.4 04:24:23 INFO - 2015-11-20 04:24:23,550 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,551 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5160.48 Median:6327.65 stddev:2641.52 (41.7%) stddev-sans-first:2633.47 04:24:23 INFO - 2015-11-20 04:24:23,551 DEBUG : BROWSER_OUTPUT: Values: 1357.4 1719.9 1731.3 1777.9 1780.0 6537.0 6767.6 6925.9 6931.0 6946.2 7087.0 7168.7 7193.9 7194.1 7196.3 1936.9 1959.5 1966.5 2234.2 2258.6 2013.1 2265.2 2312.6 2313.7 2314.0 2152.9 2182.3 2192.4 2192.4 2196.0 1919.4 1952.4 2222.2 2253.3 2253.4 2224.5 2269.4 2270.8 2272.1 2275.5 7086.5 7234.6 7251.4 7261.4 7266.1 4542.9 4604.9 4612.8 4615.2 4657.4 3028.9 3111.8 3152.0 3172.2 3182.8 1053.6 1091.7 1117.4 1164.8 1967.8 9913.9 9972.9 9977.7 9996.1 10005.4 4072.7 4122.8 4164.8 4258.2 4293.6 8028.4 8083.4 8083.6 8083.6 8086.9 4581.7 4597.4 4611.4 4622.4 4626.5 4255.6 4275.5 4279.5 4281.8 4284.8 3355.0 3358.0 3367.8 3399.7 3405.7 1009.5 1014.6 1016.7 1022.2 1023.6 985.3 987.8 997.7 1110.5 1298.5 6653.2 6749.4 6787.6 6812.4 6814.3 461.7 469.6 473.9 475.6 478.8 5120.5 5246.4 5334.2 5459.2 5582.6 8675.0 8912.5 9052.3 9073.1 9130.8 8767.2 8967.7 9059.8 9061.4 9075.2 6666.1 6691.7 6715.8 6721.6 6729.8 6612.7 6758.4 6772.5 6778.4 6785.5 7825.5 7999.0 8101.6 8123.1 8163.2 8123.4 8175.3 8280.2 8327.3 8394.1 6289.9 6336.3 6354.3 6355.9 6359.5 6819.2 7177.0 7191.1 7213.0 7227.8 6700.4 6760.8 6774.9 6842.1 6865.6 6575.5 6585.8 6659.2 6697.7 6757.4 6650.6 6651.4 6681.2 6686.4 6707.8 6077.2 6235.6 6274.8 6277.2 6280.7 6242.7 6320.4 6334.9 6336.3 6340.2 04:24:23 INFO - 2015-11-20 04:24:23,551 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5419.72 Median:6168.93 stddev:1648.61 (26.7%) stddev-sans-first:1608.41 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: Values: 332.6 335.2 337.5 339.4 348.0 6065.8 6076.7 6088.8 6089.1 6120.5 5802.7 5860.9 5940.9 6024.1 6048.6 4667.1 4667.4 4678.0 4697.2 4698.2 4450.1 4680.2 4682.5 4684.1 4690.7 4516.6 4518.2 4591.7 4604.6 4611.1 4555.5 4579.6 4583.5 4585.2 4587.7 4088.7 4093.1 4093.9 4094.7 4103.9 5624.9 5726.2 5731.2 5733.3 5733.8 5371.4 5381.0 5382.9 5383.7 5387.7 6485.4 6487.1 6490.1 6494.1 6496.9 4473.8 4482.4 4483.0 4483.5 4488.0 6617.3 6686.0 6693.2 6749.9 6757.1 4552.9 4553.6 4555.4 4555.6 4564.0 4605.2 4611.1 4617.3 4619.2 4624.3 5351.5 5355.3 5355.9 5360.2 5365.2 6351.8 6477.1 6495.4 6497.1 6497.2 1617.2 1621.4 1631.1 1631.8 1635.2 1073.4 1090.4 1097.7 1100.3 1120.6 6258.7 6260.0 6261.5 6266.2 6290.9 6462.2 6688.9 6711.7 6711.7 6715.1 6110.2 6217.3 6304.7 6308.3 6313.6 3583.2 3635.4 3638.1 3639.7 3645.1 6823.4 6983.7 6986.4 6987.0 6989.1 6885.7 6906.8 6918.4 6922.0 6941.9 6978.0 6982.8 6990.5 7002.4 7003.3 6603.8 6733.1 6733.4 6741.4 6741.8 6690.8 6691.1 6691.5 6696.4 6697.9 6976.5 6979.0 6985.9 6991.7 7004.1 4450.0 4552.8 4556.7 4557.3 4560.1 6698.6 6700.4 6700.4 6711.0 6711.2 6526.2 6532.0 6533.9 6534.1 6537.0 6356.6 6533.6 6534.1 6541.2 6541.3 6421.0 6428.4 6430.9 6431.1 6431.5 6522.8 6568.4 6568.6 6573.7 6574.0 6300.5 6385.3 6410.0 6412.0 6417.5 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14009.68 Median:46922.88 stddev:16387.33 (34.9%) stddev-sans-first:16403.06 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: Values: 752.5 797.4 808.7 835.0 864.3 13336.5 13461.7 13489.6 13510.2 13539.8 13004.2 13286.0 13390.3 13906.9 13919.7 815.9 832.8 833.0 833.8 833.9 809.1 815.4 818.9 819.9 820.2 852.2 861.7 863.6 864.5 865.2 857.1 858.5 859.6 859.9 861.1 624.6 627.3 628.6 629.2 629.4 12258.9 12340.6 12365.1 12367.3 12382.4 10622.0 10803.3 11202.8 11232.2 11425.3 8944.4 8999.2 9666.9 9814.3 9929.4 3478.9 3567.2 3578.7 3652.9 3658.9 40759.6 40843.4 46630.8 50266.0 51242.2 8270.9 10343.9 10477.7 10547.2 10610.6 16796.0 19146.4 19160.1 19191.7 19193.8 7716.8 7830.8 7835.9 7892.1 7899.6 4268.1 4298.5 4321.1 4353.6 4376.5 2954.2 2961.9 2983.0 2987.4 2990.9 528.5 535.8 539.3 541.6 547.4 608.9 665.2 678.2 693.4 709.6 9344.9 9383.3 9480.9 9554.8 9820.8 574.6 633.9 670.0 678.2 724.7 4180.3 4322.1 4338.3 4369.7 4499.7 59769.4 61064.0 61156.0 61168.4 61194.7 44171.3 53893.5 54244.0 54535.7 55140.7 43806.6 47215.0 50556.0 50646.0 52243.7 8619.4 8817.2 9191.2 9243.7 9253.1 32140.2 32840.7 35715.6 36366.6 38431.0 41857.8 41887.4 44514.3 49195.3 49219.8 10902.8 11091.8 11376.7 11419.7 11979.2 12495.9 12621.3 12764.9 12821.1 12906.7 11565.7 11737.7 11882.2 12064.2 12470.2 11294.3 11638.6 11882.0 11961.0 12349.4 11107.0 11363.7 11711.4 11741.1 11816.9 9969.7 10045.7 10246.3 10333.6 10464.9 9073.5 9115.3 9252.4 9559.9 9673.9 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:24:23 INFO - 2015-11-20 04:24:23,552 DEBUG : BROWSER_OUTPUT: 04:24:24 INFO - 2015-11-20 04:24:24,161 INFO : Browser exited with error code: 0 04:24:24 INFO - 2015-11-20 04:24:24,178 INFO : Completed test dromaeo_css (00:18:32) 04:24:24 INFO - 2015-11-20 04:24:24,178 INFO : Starting test kraken 04:24:24 INFO - 2015-11-20 04:24:24,178 DEBUG : operating with platform_type : linux_ 04:24:24 INFO - 2015-11-20 04:24:24,178 INFO : Initialising browser for kraken test... 04:24:24 INFO - 2015-11-20 04:24:24,184 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmtl1sE/profile http://localhost:53266/getInfo.html 04:24:27 INFO - 2015-11-20 04:24:27,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:24:27 INFO - 2015-11-20 04:24:27,899 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:24:27 INFO - 2015-11-20 04:24:27,899 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:24:27 INFO - 2015-11-20 04:24:27,899 DEBUG : BROWSER_OUTPUT: __metrics 04:24:28 INFO - 2015-11-20 04:24:28,028 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:29 INFO - 2015-11-20 04:24:29,188 INFO : Browser initialized. 04:24:29 INFO - 2015-11-20 04:24:29,189 INFO : Running cycle 1/1 for kraken test... 04:24:29 INFO - 2015-11-20 04:24:29,189 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmtl1sE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:24:40 INFO - 2015-11-20 04:24:40,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 142426112 04:24:40 INFO - 2015-11-20 04:24:40,989 DEBUG : BROWSER_OUTPUT: 04:24:43 INFO - 2015-11-20 04:24:43,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53266/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:44 INFO - 2015-11-20 04:24:44,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 180240384 04:24:44 INFO - 2015-11-20 04:24:44,075 DEBUG : BROWSER_OUTPUT: 04:24:46 INFO - 2015-11-20 04:24:46,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53266/tests/kraken/driver.html?testName=audio-dft) 04:24:47 INFO - 2015-11-20 04:24:47,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 169664512 04:24:47 INFO - 2015-11-20 04:24:47,243 DEBUG : BROWSER_OUTPUT: 04:24:50 INFO - 2015-11-20 04:24:50,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53266/tests/kraken/driver.html?testName=audio-fft) 04:24:50 INFO - 2015-11-20 04:24:50,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 151572480 04:24:50 INFO - 2015-11-20 04:24:50,679 DEBUG : BROWSER_OUTPUT: 04:24:52 INFO - 2015-11-20 04:24:52,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53266/tests/kraken/driver.html?testName=audio-oscillator) 04:24:53 INFO - 2015-11-20 04:24:53,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 154017792 04:24:53 INFO - 2015-11-20 04:24:53,239 DEBUG : BROWSER_OUTPUT: 04:24:55 INFO - 2015-11-20 04:24:55,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:55 INFO - 2015-11-20 04:24:55,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 157028352 04:24:55 INFO - 2015-11-20 04:24:55,965 DEBUG : BROWSER_OUTPUT: 04:24:58 INFO - 2015-11-20 04:24:58,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53266/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:59 INFO - 2015-11-20 04:24:59,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 157003776 04:24:59 INFO - 2015-11-20 04:24:59,413 DEBUG : BROWSER_OUTPUT: 04:25:02 INFO - 2015-11-20 04:25:02,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53266/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:03 INFO - 2015-11-20 04:25:03,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 156295168 04:25:03 INFO - 2015-11-20 04:25:03,396 DEBUG : BROWSER_OUTPUT: 04:25:06 INFO - 2015-11-20 04:25:06,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53266/tests/kraken/driver.html?testName=json-parse-financial) 04:25:06 INFO - 2015-11-20 04:25:06,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 156545024 04:25:06 INFO - 2015-11-20 04:25:06,728 DEBUG : BROWSER_OUTPUT: 04:25:08 INFO - 2015-11-20 04:25:08,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:08 INFO - 2015-11-20 04:25:08,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 166117376 04:25:08 INFO - 2015-11-20 04:25:08,836 DEBUG : BROWSER_OUTPUT: 04:25:10 INFO - 2015-11-20 04:25:10,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:11 INFO - 2015-11-20 04:25:11,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 166039552 04:25:11 INFO - 2015-11-20 04:25:11,220 DEBUG : BROWSER_OUTPUT: 04:25:13 INFO - 2015-11-20 04:25:13,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:13 INFO - 2015-11-20 04:25:13,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 170422272 04:25:13 INFO - 2015-11-20 04:25:13,839 DEBUG : BROWSER_OUTPUT: 04:25:16 INFO - 2015-11-20 04:25:16,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:16 INFO - 2015-11-20 04:25:16,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 178176000 04:25:16 INFO - 2015-11-20 04:25:16,811 DEBUG : BROWSER_OUTPUT: 04:25:19 INFO - 2015-11-20 04:25:19,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:19 INFO - 2015-11-20 04:25:19,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 177844224 04:25:19 INFO - 2015-11-20 04:25:19,885 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53266/tests/kraken/driver.html?testName=ai-astar) 04:25:21 INFO - 2015-11-20 04:25:21,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 236503040 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;103;109;109;109;98;109;109;108 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;125;150;160;124;159;151;126;165;132 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;160;159;160;162;161;161;162 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;95;72;76;72;133;88;71 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;134;89;90;90;135;90;91;133 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;109;110;109;109;109;109;110;110;110 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;146;146;146;145;145;146 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;95;95;95 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;58;57;58;58;57;65;54;56 04:25:21 INFO - 2015-11-20 04:25:21,804 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;74;70;70;70;70;69;69;70 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;85;86;93;89;85;85;91 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;121;117;113;123;116;115;116;122;115 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;146;146;145;147;138;148;147;144;135 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;67;67;65;66;66;65;65;66 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: __startTimestamp1448022321802__endTimestamp 04:25:21 INFO - 2015-11-20 04:25:21,805 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:25:21 INFO - 2015-11-20 04:25:21,806 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:4.06 (3.7%) stddev-sans-first:4.21 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 103.0 109.0 109.0 109.0 98.0 109.0 109.0 108.0 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.50 stddev:15.82 (10.5%) stddev-sans-first:16.71 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: Values: 148.0 125.0 150.0 160.0 124.0 159.0 151.0 126.0 165.0 132.0 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 160.0 159.0 160.0 162.0 161.0 161.0 162.0 04:25:21 INFO - 2015-11-20 04:25:21,807 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:19.28 (26.1%) stddev-sans-first:19.99 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 95.0 72.0 76.0 72.0 133.0 88.0 71.0 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:90.00 stddev:21.26 (23.6%) stddev-sans-first:22.01 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 134.0 89.0 90.0 90.0 135.0 90.0 91.0 133.0 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 04:25:21 INFO - 2015-11-20 04:25:21,808 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,809 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:25:21 INFO - 2015-11-20 04:25:21,809 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 04:25:21 INFO - 2015-11-20 04:25:21,809 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,810 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:25:21 INFO - 2015-11-20 04:25:21,810 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 04:25:21 INFO - 2015-11-20 04:25:21,810 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,810 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:2.88 (5.0%) stddev-sans-first:3.04 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 58.0 57.0 58.0 58.0 57.0 65.0 54.0 56.0 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:1.56 (2.2%) stddev-sans-first:1.48 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 74.0 70.0 70.0 70.0 70.0 69.0 69.0 70.0 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:3.16 (3.7%) stddev-sans-first:3.20 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 85.0 86.0 93.0 89.0 85.0 85.0 91.0 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.00 stddev:6.72 (5.6%) stddev-sans-first:3.54 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: Values: 136.0 121.0 117.0 113.0 123.0 116.0 115.0 116.0 122.0 115.0 04:25:21 INFO - 2015-11-20 04:25:21,811 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:146.00 stddev:4.50 (3.1%) stddev-sans-first:4.47 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: Values: 139.0 146.0 146.0 145.0 147.0 138.0 148.0 147.0 144.0 135.0 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 67.0 65.0 66.0 66.0 65.0 65.0 66.0 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:25:21 INFO - 2015-11-20 04:25:21,812 DEBUG : BROWSER_OUTPUT: 04:25:22 INFO - 2015-11-20 04:25:22,661 INFO : Browser exited with error code: 0 04:25:22 INFO - 2015-11-20 04:25:22,709 INFO : Completed test kraken (00:00:58) 04:25:22 INFO - 2015-11-20 04:25:22,709 INFO : Starting test v8_7 04:25:22 INFO - 2015-11-20 04:25:22,709 DEBUG : operating with platform_type : linux_ 04:25:22 INFO - 2015-11-20 04:25:22,709 INFO : Initialising browser for v8_7 test... 04:25:22 INFO - 2015-11-20 04:25:22,715 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmGgTvK/profile http://localhost:53266/getInfo.html 04:25:26 INFO - 2015-11-20 04:25:26,407 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:25:26 INFO - 2015-11-20 04:25:26,407 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:25:26 INFO - 2015-11-20 04:25:26,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:25:26 INFO - 2015-11-20 04:25:26,407 DEBUG : BROWSER_OUTPUT: __metrics 04:25:26 INFO - 2015-11-20 04:25:26,483 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:27 INFO - 2015-11-20 04:25:27,784 INFO : Browser initialized. 04:25:27 INFO - 2015-11-20 04:25:27,784 INFO : Running cycle 1/1 for v8_7 test... 04:25:27 INFO - 2015-11-20 04:25:27,784 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmGgTvK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:25:39 INFO - 2015-11-20 04:25:39,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 04:25:39 INFO - 2015-11-20 04:25:39,520 DEBUG : BROWSER_OUTPUT: 04:26:00 INFO - 2015-11-20 04:26:00,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53266/tests/v8_7/run.html (next: http://localhost:53266/tests/v8_7/run.html) 04:26:01 INFO - 2015-11-20 04:26:01,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 609882112 04:26:01 INFO - 2015-11-20 04:26:01,192 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,192 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:26:01 INFO - 2015-11-20 04:26:01,192 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:26:01 INFO - 2015-11-20 04:26:01,192 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |0;Richards;162.5487646293888 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.06171162429652 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.9814762040467 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |6;Boyer;12265.060240963856 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |7;RegExp;25743.589743589742 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |8;Splay;642.6735218508998 04:26:01 INFO - 2015-11-20 04:26:01,193 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: __startTimestamp1448022361186__endTimestamp 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.55 Median:162.55 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: Values: 162.5 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.06 Median:194.06 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: Values: 194.1 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.98 Median:284.98 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: Values: 285.0 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,194 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: Values: 5040.2 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: Values: 1108.6 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: Values: 787.4 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12265.06 Median:12265.06 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: Values: 12265.1 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: Values: 25743.6 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:642.67 Median:642.67 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: Values: 642.7 04:26:01 INFO - 2015-11-20 04:26:01,195 DEBUG : BROWSER_OUTPUT: 04:26:01 INFO - 2015-11-20 04:26:01,196 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:26:01 INFO - 2015-11-20 04:26:01,196 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:26:01 INFO - 2015-11-20 04:26:01,196 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:26:01 INFO - 2015-11-20 04:26:01,196 DEBUG : BROWSER_OUTPUT: 04:26:02 INFO - 2015-11-20 04:26:02,105 INFO : Browser exited with error code: 0 04:26:02 INFO - 2015-11-20 04:26:02,124 INFO : Completed test v8_7 (00:00:39) 04:26:02 INFO - 2015-11-20 04:26:02,183 INFO : Completed test suite (00:20:10) 04:26:02 INFO - 2015-11-20 04:26:02,184 DEBUG : Working with test: dromaeo_css 04:26:02 INFO - 2015-11-20 04:26:02,184 DEBUG : Generating results file: dromaeo_css 04:26:02 INFO - 2015-11-20 04:26:02,185 DEBUG : Working with test: kraken 04:26:02 INFO - 2015-11-20 04:26:02,185 DEBUG : Generating results file: kraken 04:26:02 INFO - 2015-11-20 04:26:02,185 INFO : javascript benchmark 04:26:02 INFO - 2015-11-20 04:26:02,186 DEBUG : Working with test: v8_7 04:26:02 INFO - 2015-11-20 04:26:02,186 DEBUG : Generating results file: v8_7 04:26:02 INFO - 2015-11-20 04:26:02,186 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:02 INFO - 2015-11-20 04:26:02,241 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 04:26:02 INFO - 2015-11-20 04:26:02,241 DEBUG : process_Request line: dromaeo_css 7007.14 graph.html#tests=[[72,64,35]] 04:26:02 INFO - 2015-11-20 04:26:02,241 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:02 INFO - 2015-11-20 04:26:02,288 DEBUG : process_Request line: kraken 1492.20 graph.html#tests=[[232,64,35]] 04:26:02 INFO - 2015-11-20 04:26:02,288 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:02 INFO - 2015-11-20 04:26:02,321 DEBUG : process_Request line: v8_7 20923.33 graph.html#tests=[[230,64,35]] 04:26:02 INFO - 2015-11-20 04:26:02,322 INFO : javascript benchmark 04:26:02 INFO - 2015-11-20 04:26:02,326 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3171.762117841162, 3200.3119329344186, 3238.2228265216354, 3242.2218667519787, 3267.5425440438344, 5238.109521381365, 5249.265102885594, 5310.548603368708, 5358.33020872391, 5367.597430192732, 5276.3668359796875, 5282.973585132069, 5354.946450535494, 5358.732063396825, 5405.675659460425, 4815.061063092707, 4874.829380971667, 4943.505649435046, 4953.207486802113, 5033.043721692867, 4820.228763397857, 5012.172991456406, 5030.748462576875, 5055.0, 5111.412187598418, 4789.018251258501, 4894.388201474816, 4900.436449808282, 4930.2851086592245, 4933.7533123343865, 4869.586085182764, 4908.705477671316, 4920.015996800654, 4922.507749225085, 4947.307376967227, 4704.976475117637, 4891.559759621616, 4894.559489645913, 4899.412070551521, 4949.307097006422, 5087.618428617831, 5188.195829646411, 5203.765830537635, 5208.869778255536, 5236.947630523722, 5836.328822185461, 5838.036723940545, 5850.736716847752, 5852.063669812809, 5853.560982926298, 5625.915611265835, 5812.360640329561, 5893.351731309553, 5893.764249430018, 5898.705064746789, 5369.81205657804, 5442.91835622466, 5443.537299329561, 5445.863853403696, 5496.560275177976, 5910.320313164041, 5947.672877991752, 5974.283086029617, 5977.820665380045, 5979.850503737442, 5534.08687566547, 5638.915416268759, 5639.887202255932, 5769.653820770767, 5770.451807078321, 5701.230333904869, 5768.9711551442815, 5805.651660900359, 5820.592558520862, 5822.068469045017, 5735.053716136874, 5775.335836378787, 5776.913346299809, 5828.0, 5828.825135245949, 5664.773409063591, 5795.565332600072, 5804.303483581913, 5805.216295800097, 5814.186013958049, 4396.230659634615, 4480.731156130578, 4488.573585509372, 4491.214037543416, 4522.728636281834, 3984.4620976168426, 3984.7011474139554, 3990.18201268745, 4004.619561141687, 4029.536603290659, 5412.431694672082, 5413.891722165535, 5414.891702166014, 5419.160030195326, 5479.506844384025, 5694.658320500783, 5720.885582288331, 5818.8254352369495, 5824.767009319579, 5851.151583020438, 5510.393856675762, 5534.446555344433, 5537.501624853702, 5539.14143307788, 5541.639793413416, 5133.050385678586, 5143.562797162208, 5160.391903317298, 5165.819196328111, 5207.765650545734, 5791.449812267828, 5857.238558987305, 5861.325947516005, 5926.0, 5962.850928726816, 5772.7690892363835, 5798.536117110705, 5896.646201227769, 5899.469047785548, 5903.291605007426, 6019.638821670714, 6054.273487181566, 6058.394160583906, 6058.909116363347, 6059.818205453844, 5596.440355964371, 5659.603827732019, 5725.255716756795, 5799.76800927975, 5817.127430885401, 5761.539076873756, 5902.586818922634, 5903.822885313448, 5904.439078287556, 5961.433663801932, 5721.628094173865, 5743.913841292468, 5744.368119506935, 5747.339056008613, 5752.050911599539, 5498.202760599771, 5539.639923404966, 5598.3282006159525, 5700.572457065819, 5724.656520608777, 5496.890062198813, 5544.473275038865, 5552.3892371839875, 5556.083246264483, 5567.081431563909, 5707.972564938351, 5721.456461636138, 5733.02538568436, 5735.7705691773535, 5738.368779434342, 5412.594055445936, 5612.85967850807, 5624.128260119688, 5625.718714064198, 5628.0432326505415], "unit": "ms", "name": "dojo.html", "value": 5346.209766373008}, {"lowerIsBetter": false, "replicates": [552.3040968379843, 575.0597772641729, 590.5098768022542, 594.7680404642189, 602.5089552015108, 30954.690453095463, 31751.36497270056, 31768.523472147906, 39765.80117099418, 40598.797006015004, 43340.56659433412, 43862.78068609653, 43939.78030109845, 43976.78011609938, 44006.55993440065, 8710.608022638997, 8884.289256859469, 8889.111088891124, 8894.377393582452, 8896.199342059213, 7563.357114645261, 7833.451658383916, 7833.686652533892, 10368.844467332996, 10624.734381640443, 10387.84418233727, 10470.057694807465, 10488.318259313159, 10491.842622360633, 10506.894931050707, 10464.162866970662, 10556.577736890515, 10560.947195263974, 10561.468587054873, 10573.259871808976, 7791.571463569501, 8025.23760242776, 10386.79226415475, 10686.839697404468, 10700.464976751131, 40301.0, 40745.185096298206, 40755.184896302206, 40800.0, 40816.0, 3086.506159014569, 3230.1924518870283, 3675.9891029966707, 3701.03773019017, 3760.417135344026, 29980.250493737614, 30251.0, 30709.232269193224, 30854.0, 31141.221469463217, 3943.507061617298, 3975.542812576533, 3979.5025621797276, 4059.9188016239805, 4061.248668996245, 284670.0, 284692.0, 285929.0, 286162.0, 286608.0, 49637.25544116841, 58600.0, 58794.0, 58880.0, 58936.70531647314, 52181.217281740806, 68134.0, 68636.6568167166, 68643.7627484705, 68716.31283687199, 16047.598810029609, 16106.275217615235, 16313.510594682179, 16317.673646527002, 16325.26536305869, 12424.37878106091, 12480.18878772895, 12493.12548121641, 12502.499900003899, 12519.687007824878, 19084.0, 19364.128614212394, 19392.90303548473, 19411.708824367644, 19437.4168774937, 7496.362809161174, 7696.960910277153, 7719.150893401721, 7772.396247257232, 7816.41376896735, 895.9776005599912, 959.1032384720309, 1012.9594816207417, 1106.3343356278326, 1111.1166622535104, 28590.428191436054, 28773.856130719632, 28787.75040248793, 28942.855285723857, 29178.708212918023, 1019.3628981886321, 1031.376017509411, 1048.0829274384914, 1075.4676435164642, 1108.728361551425, 12625.0, 13523.39144738489, 13662.385192666354, 13756.587302380945, 14110.647233819236, 336136.0, 342074.0, 342311.0, 342982.0, 343255.0, 51908.0, 52051.47948520466, 52059.47940520622, 52089.21866172011, 52121.7393913028, 1352.2562590575144, 1364.8225730654951, 1372.2041216094642, 1374.202962281874, 1388.8125103110951, 26776.0, 27339.179824605293, 27907.720922791323, 28039.299017524725, 28107.71892281051, 42269.577304227794, 43640.0, 43933.340999885666, 44387.55612443834, 44427.555724443635, 425766.0, 437088.0, 441843.0, 443756.0, 443885.0, 31808.840955795073, 32200.19499512531, 32256.838715806272, 32258.19354516062, 32275.35449291048, 42522.36216456694, 43060.56939430691, 43098.56901431071, 43364.78317608392, 43998.340024900295, 36266.63733362633, 36352.81823590865, 36398.81800591086, 36546.0, 37696.811515943344, 34721.479177811845, 34874.47688284627, 35103.64896351004, 35298.64701352954, 35380.46929296011, 36305.27389452144, 38258.8087059574, 38963.80518097391, 39264.214715704955, 39319.80340098281, 30738.385232295677, 33164.005079847644, 33859.4921076189, 34095.14762130967, 34164.65835341615, 25950.740492594832, 27169.0, 27227.319317017234, 27339.31651708723, 27487.0], "unit": "ms", "name": "ext.html", "value": 19124.73756218678}, {"lowerIsBetter": false, "replicates": [353.9928604810723, 358.38000259550995, 359.591863235228, 360.3873415194169, 363.42034455044194, 14169.574912752609, 14230.146191228534, 16553.420630277942, 16843.326266949323, 17515.91242043791, 11077.169212309089, 11363.431828408588, 16070.678586428294, 17040.488785336427, 17119.486415407526, 4822.493638168004, 4931.605471562267, 4936.407631084275, 4937.753112344386, 4938.160512712848, 3572.1962558424407, 3682.760620559655, 4869.123557759602, 4892.046051020035, 5285.920711189336, 5350.705711185883, 5373.543248823855, 5382.950324686668, 5423.240746295522, 5431.049566325897, 5212.582993360522, 5366.731663416814, 5374.91937620936, 5420.349558053039, 5421.996930567838, 4975.776090075955, 5114.820981265638, 5122.820701275475, 5152.845414637567, 5172.043172013152, 19493.610127797507, 19529.707054394195, 20015.29946451882, 20210.0, 20213.19147234109, 1915.9137838797149, 1968.2028778344793, 2004.4988752811796, 2020.666590012646, 2041.071312552785, 9662.32363734539, 9704.90295097047, 9986.450745209011, 11995.760084798343, 12597.496100155982, 1821.6174603333316, 1922.692369220918, 1925.9995033523714, 1938.9612207755906, 2002.619502294574, 60803.39196608021, 63358.0, 63967.68016159936, 64033.679831600544, 64503.354966450206, 10171.4914254287, 10245.334053286513, 10267.075963163352, 10283.74290642725, 10319.896801032044, 13502.932485337707, 13526.565218260808, 13533.593992180251, 13537.323133843269, 13540.93229533846, 7781.416393770377, 7844.725434609875, 7845.764627061198, 7887.487313324616, 7909.881351779728, 7701.422393320523, 7724.92275077242, 7726.536407815549, 7760.185180556074, 7778.377729781604, 4392.978035109804, 4454.888627784267, 4472.1502914446155, 4480.103979204107, 4485.945802736354, 1679.8908070975347, 1734.8698847586481, 1788.3115000724815, 1809.5928416106271, 1862.8323450889486, 858.4934888415864, 876.4390789894472, 889.2086043421231, 910.649399981012, 958.7603099225194, 16122.355105795872, 16536.421225257058, 16784.580385490215, 16880.493585192464, 16973.40593079261, 814.5764202614607, 869.4652788535005, 884.1821315283337, 894.2443635128307, 899.9730008099767, 9134.588943497558, 9345.392549484262, 9348.158665720119, 9402.01278865723, 9412.435253884789, 565961.0, 566102.0, 567925.0, 590918.0, 591414.0, 83018.75471867927, 84899.5755021221, 85884.57057714672, 86258.0, 87528.0, 1114.8272017837248, 1138.072470936201, 1141.6232643227715, 1161.2567956507842, 1184.2420850655587, 15230.390784368501, 15750.527484175493, 15785.763213552036, 15948.68102637964, 16073.517794466185, 36283.818580906925, 36555.634443655224, 36638.0, 36747.63252367549, 37084.81457592695, 48083.519164807905, 48800.75599621979, 49844.750776245884, 52023.219651706015, 54016.45983540114, 9033.95483022607, 9041.593128309374, 9052.3210759192, 9142.131497507726, 9594.18449431806, 17164.22760975734, 17519.21163547618, 17735.201915914073, 17881.19534620919, 17922.103894805467, 13938.790918136034, 14070.296485175495, 14314.570562882713, 14771.778423323443, 14886.330115145061, 13907.774756038985, 13991.720165596427, 14200.147991120566, 14368.425262989782, 14465.349059292146, 11512.0, 12010.0, 12787.680307992374, 14601.70796584041, 15002.849971500582, 9456.19622332082, 9466.195373393339, 9500.572474238814, 9653.46905920181, 9653.758656033655, 14406.567802965928, 14505.347259373142, 14933.551993440215, 15190.848091518943, 15469.381224751334], "unit": "ms", "name": "jquery.html", "value": 8837.181286060848}, {"lowerIsBetter": false, "replicates": [1357.4434481862438, 1719.9398021069262, 1731.2555601091533, 1777.85777137829, 1779.9644007119857, 6536.967315163423, 6767.627780472072, 6925.896111558318, 6930.965345173279, 6946.235914049451, 7087.007818905345, 7168.677409516571, 7193.89209161863, 7194.100737407824, 7196.280371962801, 1936.8547358948065, 1959.4513536209884, 1966.4985428715659, 2234.162189179062, 2258.627326491127, 2013.0941076515553, 2265.184533567914, 2312.560613483433, 2313.699219101523, 2314.0, 2152.9138834446603, 2182.301663467691, 2192.3970908000347, 2192.4080498265457, 2196.0, 1919.4145785535407, 1952.3947576251408, 2222.1777942161425, 2253.2902135827244, 2253.3690566641367, 2224.455008522922, 2269.3986093685185, 2270.7615700351557, 2272.091163534583, 2275.5448910218024, 7086.468514861406, 7234.5659260444545, 7251.383632391253, 7261.382782463497, 7266.128064632225, 4542.863714088583, 4604.907901841978, 4612.76936153191, 4615.169269531483, 4657.394538709946, 3028.9394212115635, 3111.7821752477334, 3152.0, 3172.2069482629345, 3182.793118447317, 1053.6101642392364, 1091.6670415523263, 1117.3854380090918, 1164.7728692904886, 1967.7737060238112, 9913.851292230622, 9972.850407243897, 9977.700668979942, 9996.050375214343, 10005.449700266483, 4072.6741860651077, 4122.7732474713575, 4164.7709375984, 4258.169656916872, 4293.613574778285, 8028.438009339407, 8083.434159608889, 8083.555404452812, 8083.636236369378, 8086.9191308086165, 4581.679282450196, 4597.42532183477, 4611.446626404786, 4622.422197225347, 4626.537346265347, 4255.5744425557195, 4275.46556680415, 4279.507856596469, 4281.807318670667, 4284.807183676742, 3355.0, 3358.009387230773, 3367.7979321240805, 3399.7110245629397, 3405.6594340565744, 1009.4700282351824, 1014.6398028699705, 1016.7051555049101, 1022.2077889635592, 1023.6161439460202, 985.2955137077024, 987.8370068938689, 997.7356000659831, 1110.5113749949996, 1298.5195477673133, 6653.168353955755, 6749.42629876466, 6787.6266805325195, 6812.420944219797, 6814.250432452426, 461.7114303560275, 469.60553135365774, 473.8554740804019, 475.55535574237507, 478.849162513807, 5120.462351453119, 5246.422893481714, 5334.199870019451, 5459.181122831527, 5582.637128586629, 8675.0, 8912.465252084896, 9052.321075919332, 9073.13805188506, 9130.817383652422, 8767.21095101444, 8967.730968070968, 9059.773505662411, 9061.41100828444, 9075.183233509017, 6666.100076489709, 6691.7323307068145, 6715.7985260442265, 6721.596704197764, 6729.798106056826, 6612.702428390638, 6758.357955994173, 6772.492063095189, 6778.389944904982, 6785.457163427012, 7825.452218344889, 7999.0, 8101.635426405944, 8123.147069557847, 8163.183681631789, 8123.4313598047565, 8175.345972322319, 8280.171982801672, 8327.333813294801, 8394.118617545315, 6289.874202516015, 6336.334684858023, 6354.26925903527, 6355.936440635534, 6359.459445947146, 6819.215790183994, 7176.96411517939, 7191.101112360955, 7213.0, 7227.7831665050135, 6700.363465470772, 6760.797176084725, 6774.898376524455, 6842.110525631835, 6865.5537390069485, 6575.539712220098, 6585.80242592723, 6659.234188068434, 6697.732090716317, 6757.391834734897, 6650.567713098633, 6651.43462805667, 6681.198256209286, 6686.398224159849, 6707.765228216989, 6077.179580756718, 6235.563510554218, 6274.843128921813, 6277.15258440123, 6280.717367718372, 6242.687865606792, 6320.367963203643, 6334.9366506334345, 6336.303006669171, 6340.175777149126], "unit": "ms", "name": "mootools.html", "value": 4206.365440171394}, {"lowerIsBetter": false, "replicates": [332.6141675656239, 335.17714012100294, 337.50386931211125, 339.40603943099575, 347.99304013919715, 6065.757369705212, 6076.696165191739, 6088.8477788055325, 6089.086637004451, 6120.54095942805, 5802.680852553108, 5860.941390586093, 5940.88118237635, 6024.066269728188, 6048.576599638027, 4667.1365797327435, 4667.393238878941, 4677.953220467786, 4697.224957881946, 4698.2482802751565, 4450.065486247891, 4680.227762419214, 4682.531746825324, 4684.063187362541, 4690.742009189493, 4516.616087632555, 4518.164139634178, 4591.691367960132, 4604.562566556172, 4611.077784443108, 4555.4533455985165, 4579.610733087675, 4583.495815460296, 4585.220512512864, 4587.747673877935, 4088.713790034699, 4093.099518106012, 4093.9181216375805, 4094.7338423002707, 4103.85636502721, 5624.915626265569, 5726.169705392695, 5731.197632331477, 5733.312002559678, 5733.799317023884, 5371.355437347504, 5381.0, 5382.91925621116, 5383.650062745948, 5387.730613469311, 6485.416312531895, 6487.124238227826, 6490.0589414534625, 6494.058361537598, 6496.902546461807, 4473.821047158142, 4482.394876691637, 4483.0, 4483.529229430928, 4488.035072459437, 6617.338266173344, 6686.030525573813, 6693.2302785179845, 6749.93250067498, 6757.087793147911, 4552.931706024412, 4553.612942899825, 4555.40779698637, 4555.589996900295, 4563.977180114144, 4605.217113090783, 4611.146937816515, 4617.284320930261, 4619.214733495314, 4624.3294722265755, 5351.491608297206, 5355.250264962909, 5355.892882142335, 5360.249565060894, 5365.195220716846, 6351.793159299718, 6477.125588045647, 6495.447886929569, 6497.090407342976, 6497.220333560003, 1617.24797968945, 1621.367666610023, 1631.111044480761, 1631.7715519827234, 1635.215096753565, 1073.431081526792, 1090.3893819460968, 1097.7145942055124, 1100.3178029621686, 1120.6133883810073, 6258.718357673915, 6260.0, 6261.530385221126, 6266.24805023391, 6290.905636415458, 6462.192225971754, 6688.933110668831, 6711.664416779142, 6711.664416779239, 6715.127033485615, 6110.205673262448, 6217.316095229521, 6304.716287767062, 6308.296759874808, 6313.55805093639, 3583.229605634749, 3635.4183330666965, 3638.072291565634, 3639.6906262967946, 3645.0705070206927, 6823.420009299166, 6983.685734141975, 6986.44108471321, 6987.0, 6989.0564773755905, 6885.657296827171, 6906.758263460755, 6918.37734603878, 6921.965390173118, 6941.861162776716, 6978.0, 6982.825429364307, 6990.510664253555, 7002.439804815603, 7003.3346832050875, 6603.80188594343, 6733.124693789972, 6733.3939945405145, 6741.359570840762, 6741.831454213684, 6690.765823196165, 6691.130153080263, 6691.46468282546, 6696.430803381572, 6697.866042679217, 6976.476764242803, 6979.0, 6985.860282794417, 6991.720331186695, 7004.124484439445, 4449.955500444954, 4552.840650577214, 4556.726596404226, 4557.316402539513, 4560.1335746208115, 6698.56459330142, 6700.363465470772, 6700.396964273239, 6711.0, 6711.161104861892, 6526.151600291932, 6531.967340163459, 6533.8693226136165, 6534.052562378523, 6537.0, 6356.586821856565, 6533.575317604341, 6534.085228067979, 6541.215054193527, 6541.280459149585, 6420.967895160495, 6428.389303016206, 6430.871382572229, 6431.1317972073175, 6431.517636177212, 6522.836929076811, 6568.408843204134, 6568.573042752206, 6573.704183311666, 6573.967130164318, 6300.495960323255, 6385.329540398191, 6410.0, 6412.0, 6417.518686098468], "unit": "ms", "name": "prototype.html", "value": 4882.196317130102}, {"lowerIsBetter": false, "replicates": [752.5484709174495, 797.3700776386655, 808.688654867876, 834.9707760228389, 864.3171894203577, 13336.466541338346, 13461.730765384698, 13489.595312140627, 13510.189388636663, 13539.79690304645, 13004.154729942547, 13286.0, 13390.263535505543, 13906.860931390684, 13919.721605567882, 815.926566609005, 832.8375966686499, 833.0336809301211, 833.7790485521342, 833.9207775261341, 809.1423091522975, 815.4006804998321, 818.9262966333029, 819.9385046121535, 820.1716266570747, 852.1776485691306, 861.732862812527, 863.6027427383411, 864.5115509736978, 865.1521508921261, 857.1428571428571, 858.5235194467068, 859.5788063848731, 859.879616853641, 861.0915484164204, 624.6064979063207, 627.3068259573197, 628.6196850905183, 629.2071989293478, 629.408356145222, 12258.938705306417, 12340.568080117153, 12365.134440589163, 12367.257964522158, 12382.380880955916, 10622.0, 10803.297785643908, 11202.775944481065, 11232.157588180919, 11425.302792907078, 8944.373893827435, 8999.190072893405, 9666.903330966741, 9814.312998090136, 9929.3545919515, 3478.89563313101, 3567.161716996504, 3578.7315951303494, 3652.945205821915, 3658.9085272868124, 40759.592404076175, 40843.38734918978, 46630.76684616589, 50266.0, 51242.23136652916, 8270.917290827136, 10343.9482802587, 10477.68566942993, 10547.156227501782, 10610.575576976835, 16796.0, 19146.425607231806, 19160.137793799313, 19191.712124318146, 19193.80806191948, 7716.807079823049, 7830.765077047698, 7835.882461763078, 7892.131865494791, 7899.644515996794, 4268.125034367947, 4298.4841818981295, 4321.135772845443, 4353.564643535685, 4376.474823021194, 2954.246667099919, 2961.8815247390294, 2982.9850850746043, 2987.357718090621, 2990.8953186638364, 528.4609698107985, 535.8097875254307, 539.2692901119005, 541.5910987204635, 547.3951283831389, 608.89119529493, 665.2349797732646, 678.1827897383641, 693.445243804954, 709.5636183747062, 9344.90655093454, 9383.296252781069, 9480.90519094814, 9554.75463266132, 9820.753590896362, 574.6006525464762, 633.9349892181087, 669.9765508207189, 678.1523096129838, 724.6847621284758, 4180.26845302077, 4322.113966636832, 4338.284183109815, 4369.650427965818, 4499.707519011254, 59769.402305976386, 61064.0, 61156.0, 61168.38831611627, 61194.694026529585, 44171.337429938576, 53893.461065388845, 54244.0, 54535.72732136314, 55140.72429637826, 43806.56193438089, 47215.0, 50556.0, 50646.0, 52243.73878130661, 8619.353548484014, 8817.206451419403, 9191.242627211675, 9243.722688319362, 9253.120953509406, 32140.19649508781, 32840.671593284715, 35715.64284357227, 36366.63633363633, 38431.0, 41857.79071104625, 41887.371689425294, 44514.3322850164, 49195.262071068246, 49219.753901230266, 10902.836457452986, 11091.778164436504, 11376.715582110513, 11419.714507137389, 11979.161458697807, 12495.93752031234, 12621.305828179538, 12764.872351276368, 12821.102522823312, 12906.741865162456, 11565.710857228636, 11737.706557336134, 11882.22765520273, 12064.215825971283, 12470.189437686522, 11294.265872718248, 11638.592649257236, 11882.049436045269, 11961.043116550829, 12349.444275007467, 11107.0, 11363.715907102389, 11711.355875426932, 11741.119416044, 11816.940915295369, 9969.700908972742, 10045.748856278651, 10246.282760207012, 10333.586656533955, 10464.895351046393, 9073.45559266446, 9115.270778337584, 9252.398594091363, 9559.856602150834, 9673.854892176763], "unit": "ms", "name": "yui.html", "value": 6378.575439491165}], "name": "dromaeo_css", "value": 7007.134357136869}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 103.0, 109.0, 109.0, 109.0, 98.0, 109.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 150.0, 160.0, 124.0, 159.0, 151.0, 126.0, 165.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 160.0, 159.0, 160.0, 162.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 85.0, 95.0, 72.0, 76.0, 72.0, 133.0, 88.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 134.0, 89.0, 90.0, 90.0, 135.0, 90.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 57.0, 58.0, 58.0, 57.0, 65.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 74.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 86.0, 93.0, 89.0, 85.0, 85.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [136.0, 121.0, 117.0, 113.0, 123.0, 116.0, 115.0, 116.0, 122.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [139.0, 146.0, 146.0, 145.0, 147.0, 138.0, 148.0, 147.0, 144.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1492.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.5487646293888], "unit": "score", "name": "Richards", "value": 217.177904}, {"lowerIsBetter": false, "replicates": [194.06171162429652], "unit": "score", "name": "DeltaBlue", "value": 340.70605400000017}, {"lowerIsBetter": false, "replicates": [284.9814762040467], "unit": "score", "name": "Encrypt", "value": 934.0291290000002}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12265.060240963856], "unit": "score", "name": "Boyer", "value": 54.338338899803546}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [642.6735218508998], "unit": "score", "name": "Splay", "value": 126.799996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20923.326537057947}]} 04:26:02 INFO - RETURN: dromaeo_css: 7007.14 04:26:02 INFO - RETURN: kraken: 1492.20 04:26:02 INFO - RETURN: v8_7: 20923.33 04:26:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20923.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1492.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7007.14"}}} 04:26:02 INFO - Return code: 0 04:26:02 INFO - # TBPL SUCCESS # 04:26:02 INFO - Running post-action listener: _resource_record_post_action 04:26:02 INFO - Running post-run listener: _resource_record_post_run 04:26:03 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 512466944; Read time: 0; Write time: 595732 04:26:03 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 242331648; Read time: 0; Write time: 415360 04:26:03 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 265347072; Read time: 0; Write time: 180060 04:26:03 INFO - Running post-run listener: _upload_blobber_files 04:26:03 INFO - Blob upload gear active. 04:26:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:26:03 INFO - Copying logs to upload dir... 04:26:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.077364 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-20 04:26:02.854984) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:02.858176) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010015 build_url: 'https://queue.taskcluster.net/v1/task/Zlbo2YNaQEWHSgQryI89kw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:02.909013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:02.909368) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1448013654.154177-1295705960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:26:02.958637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:26:02.958961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:26:02.959255) ========= ========= Total master_lag: 0.22 =========