builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0049 starttime: 1447101896.04 results: success (0) buildid: 20151109111239 builduid: 141ab729bbc84886beb4a020de5e8b48 revision: 67fbffadaa47af2ba4d397f34f6c07e909bf0d6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.041587) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.042078) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.042410) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005663 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.064466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.064775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.080623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.080964) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005185 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.129339) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.129693) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.130045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.130341) ========= 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/. (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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-09 12:44:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 7.79M=0.001s 2015-11-09 12:44:56 (7.79 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156388 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.302400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.302732) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.020226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.352391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.352766) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 67fbffadaa47af2ba4d397f34f6c07e909bf0d6e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 67fbffadaa47af2ba4d397f34f6c07e909bf0d6e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-09 12:44:56,427 truncating revision to first 12 chars 2015-11-09 12:44:56,428 Setting DEBUG logging. 2015-11-09 12:44:56,428 attempt 1/10 2015-11-09 12:44:56,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/67fbffadaa47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 12:44:56,795 unpacking tar archive at: fx-team-67fbffadaa47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.982799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.983116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.996135) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.996624) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 12:44:56.997102) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-09 12:44:56.997407) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (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/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 12:44:57 INFO - MultiFileLogger online at 20151109 12:44:57 in /builds/slave/test 12:44:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:44:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:44:57 INFO - {'append_to_log': False, 12:44:57 INFO - 'base_work_dir': '/builds/slave/test', 12:44:57 INFO - 'blob_upload_branch': 'Fx-Team', 12:44:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:44:57 INFO - 'branch': 'Fx-Team', 12:44:57 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:57 INFO - 'config_files': ('talos/mac_config.py',), 12:44:57 INFO - 'default_actions': ('clobber', 12:44:57 INFO - 'read-buildbot-config', 12:44:57 INFO - 'download-and-extract', 12:44:57 INFO - 'populate-webroot', 12:44:57 INFO - 'create-virtualenv', 12:44:57 INFO - 'install', 12:44:57 INFO - 'run-tests'), 12:44:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:57 INFO - 'download_minidump_stackwalk': True, 12:44:57 INFO - 'download_symbols': 'ondemand', 12:44:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:57 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:57 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:57 INFO - 'installer_path': 'installer.exe', 12:44:57 INFO - 'log_level': 'info', 12:44:57 INFO - 'log_name': 'talos', 12:44:57 INFO - 'log_to_console': True, 12:44:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:44:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:44:57 INFO - 'opt_config_files': (), 12:44:57 INFO - 'pip_index': False, 12:44:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:44:57 INFO - 'cmd': ('bash', 12:44:57 INFO - '-c', 12:44:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:44:57 INFO - 'enabled': True, 12:44:57 INFO - 'halt_on_failure': False, 12:44:57 INFO - 'name': 'check_screen_resolution'},), 12:44:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:44:57 INFO - 'cmd': ('bash', 12:44:57 INFO - '-c', 12:44:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:44:57 INFO - 'enabled': True, 12:44:57 INFO - 'halt_on_failure': False, 12:44:57 INFO - 'name': 'check_screen_resolution'},), 12:44:57 INFO - 'run_cmd_checks_enabled': True, 12:44:57 INFO - 'sps_profile': False, 12:44:57 INFO - 'sps_profile_interval': 0, 12:44:57 INFO - 'suite': 'dromaeojs', 12:44:57 INFO - 'system_bits': '64', 12:44:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:57 INFO - 'title': 't-yosemite-r5-0049', 12:44:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:57 INFO - 'use_talos_json': True, 12:44:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:44:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:57 INFO - 'work_dir': 'build'} 12:44:57 INFO - ##### 12:44:57 INFO - ##### Running clobber step. 12:44:57 INFO - ##### 12:44:57 INFO - Running pre-action listener: _resource_record_pre_action 12:44:57 INFO - Running main action method: clobber 12:44:57 INFO - rmtree: /builds/slave/test/build 12:44:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:00 INFO - Running post-action listener: _resource_record_post_action 12:45:00 INFO - ##### 12:45:00 INFO - ##### Running read-buildbot-config step. 12:45:00 INFO - ##### 12:45:00 INFO - Running pre-action listener: _resource_record_pre_action 12:45:00 INFO - Running main action method: read_buildbot_config 12:45:00 INFO - Using buildbot properties: 12:45:00 INFO - { 12:45:00 INFO - "properties": { 12:45:00 INFO - "buildnumber": 1225, 12:45:00 INFO - "product": "firefox", 12:45:00 INFO - "script_repo_revision": "production", 12:45:00 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 12:45:00 INFO - "repository": "", 12:45:00 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 12:45:00 INFO - "buildid": "20151109111239", 12:45:00 INFO - "slavename": "t-yosemite-r5-0049", 12:45:00 INFO - "pgo_build": "False", 12:45:00 INFO - "basedir": "/builds/slave/test", 12:45:00 INFO - "project": "", 12:45:00 INFO - "platform": "yosemite", 12:45:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:45:00 INFO - "slavebuilddir": "test", 12:45:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:45:00 INFO - "branch": "fx-team", 12:45:00 INFO - "repo_path": "integration/fx-team", 12:45:00 INFO - "stage_platform": "macosx64", 12:45:00 INFO - "builduid": "141ab729bbc84886beb4a020de5e8b48", 12:45:00 INFO - "revision": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e" 12:45:00 INFO - }, 12:45:00 INFO - "sourcestamp": { 12:45:00 INFO - "repository": "", 12:45:00 INFO - "hasPatch": false, 12:45:00 INFO - "project": "", 12:45:00 INFO - "branch": "fx-team-macosx64-talos", 12:45:00 INFO - "changes": [ 12:45:00 INFO - { 12:45:00 INFO - "category": null, 12:45:00 INFO - "files": [ 12:45:00 INFO - { 12:45:00 INFO - "url": null, 12:45:00 INFO - "name": "https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:45:00 INFO - } 12:45:00 INFO - ], 12:45:00 INFO - "repository": "", 12:45:00 INFO - "rev": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e", 12:45:00 INFO - "who": "gijskruitbosch@gmail.com", 12:45:00 INFO - "when": 1447101048, 12:45:00 INFO - "number": 6638657, 12:45:00 INFO - "comments": "Bug 1210703 - followup: fix test file used in caps and fix assertions to have actual/expected value in the right order, rs=bustage on a CLOSED TREE", 12:45:00 INFO - "project": "", 12:45:00 INFO - "at": "Mon 09 Nov 2015 12:30:48", 12:45:00 INFO - "branch": "fx-team-macosx64-talos", 12:45:00 INFO - "revlink": "", 12:45:00 INFO - "properties": [ 12:45:00 INFO - [ 12:45:00 INFO - "buildid", 12:45:00 INFO - "20151109111239", 12:45:00 INFO - "Change" 12:45:00 INFO - ], 12:45:00 INFO - [ 12:45:00 INFO - "builduid", 12:45:00 INFO - "141ab729bbc84886beb4a020de5e8b48", 12:45:00 INFO - "Change" 12:45:00 INFO - ], 12:45:00 INFO - [ 12:45:00 INFO - "pgo_build", 12:45:00 INFO - "False", 12:45:00 INFO - "Change" 12:45:00 INFO - ] 12:45:00 INFO - ], 12:45:00 INFO - "revision": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e" 12:45:00 INFO - } 12:45:00 INFO - ], 12:45:00 INFO - "revision": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e" 12:45:00 INFO - } 12:45:00 INFO - } 12:45:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:45:00 INFO - Running post-action listener: _resource_record_post_action 12:45:00 INFO - ##### 12:45:00 INFO - ##### Running download-and-extract step. 12:45:00 INFO - ##### 12:45:00 INFO - Running pre-action listener: _resource_record_pre_action 12:45:00 INFO - Running main action method: download_and_extract 12:45:00 INFO - mkdir: /builds/slave/test/build/tests 12:45:00 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')]} 12:45:00 INFO - https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:45:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/test_packages.json 12:45:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/test_packages.json 12:45:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:45:01 INFO - Downloaded 1149 bytes. 12:45:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:45:01 INFO - Using the following test package requirements: 12:45:01 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:45:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:45:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'jsshell-mac.zip'], 12:45:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:45:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:45:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:45:01 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:45:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:45:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:45:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:45:01 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:45:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:01 INFO - https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:45:17 INFO - Downloaded 17436471 bytes. 12:45:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:45:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:45:23 INFO - Return code: 0 12:45:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:45: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')]} 12:45:23 INFO - https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:45:24 INFO - Downloaded 17436471 bytes. 12:45:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:45:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:45:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:45:29 INFO - Return code: 0 12:45: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')]} 12:45:29 INFO - https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:45:30 INFO - Downloaded 11131618 bytes. 12:45:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 12:45:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:45:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:45:31 INFO - Return code: 0 12:45:31 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')]} 12:45:31 INFO - https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 12:45:35 INFO - Downloaded 108651613 bytes. 12:45:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:45:35 INFO - mkdir: /builds/slave/test/properties 12:45:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:35 INFO - Contents: 12:45:35 INFO - build_url:https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:45:35 INFO - Running post-action listener: _resource_record_post_action 12:45:35 INFO - Running post-action listener: set_extra_try_arguments 12:45:35 INFO - ##### 12:45:35 INFO - ##### Running populate-webroot step. 12:45:35 INFO - ##### 12:45:35 INFO - Running pre-action listener: _resource_record_pre_action 12:45:35 INFO - Running main action method: populate_webroot 12:45:35 INFO - Guessing talos json url... 12:45:35 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')]} 12:45:35 INFO - https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 12:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 12:45:35 INFO - Downloaded 103 bytes. 12:45:35 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:45:35 INFO - Contents: 12:45:35 INFO - 20151109111239 12:45:35 INFO - https://hg.mozilla.org/integration/fx-team/rev/67fbffadaa47af2ba4d397f34f6c07e909bf0d6e 12:45:35 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')]} 12:45:35 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/67fbffadaa/testing/talos/talos.json 12:45:35 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/67fbffadaa/testing/talos/talos.json to /builds/slave/test/build/talos.json 12:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/67fbffadaa/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 12:45:36 INFO - Downloaded 4206 bytes. 12:45:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:36 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:45:36 INFO - '../fennec_ids.txt'], 12:45:36 INFO - 'tests': ['tcheck2']}, 12:45:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:36 INFO - '--tppagecycles', 12:45:36 INFO - '7'], 12:45:36 INFO - 'tests': ['tsvgm']}}, 12:45:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:45:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:45:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:45:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'tests': ['damp', 'tps']}, 12:45:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['damp', 'tps']}, 12:45:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:45:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:36 INFO - 'other': {'tests': ['a11yr', 12:45:36 INFO - 'ts_paint', 12:45:36 INFO - 'tpaint', 12:45:36 INFO - 'sessionrestore', 12:45:36 INFO - 'sessionrestore_no_auto_restore']}, 12:45:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['a11yr', 12:45:36 INFO - 'ts_paint', 12:45:36 INFO - 'tpaint', 12:45:36 INFO - 'sessionrestore', 12:45:36 INFO - 'sessionrestore_no_auto_restore']}, 12:45:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['a11yr', 12:45:36 INFO - 'ts_paint', 12:45:36 INFO - 'tpaint', 12:45:36 INFO - 'sessionrestore', 12:45:36 INFO - 'sessionrestore_no_auto_restore']}, 12:45:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['a11yr', 12:45:36 INFO - 'ts_paint', 12:45:36 INFO - 'tpaint', 12:45:36 INFO - 'sessionrestore', 12:45:36 INFO - 'sessionrestore_no_auto_restore']}, 12:45:36 INFO - 'other_l64': {'tests': ['a11yr', 12:45:36 INFO - 'ts_paint', 12:45:36 INFO - 'tpaint', 12:45:36 INFO - 'sessionrestore', 12:45:36 INFO - 'sessionrestore_no_auto_restore']}, 12:45:36 INFO - 'other_nol64': {'tests': ['a11yr', 12:45:36 INFO - 'ts_paint', 12:45:36 INFO - 'tpaint', 12:45:36 INFO - 'sessionrestore', 12:45:36 INFO - 'sessionrestore_no_auto_restore']}, 12:45:36 INFO - 'svgr': {'tests': ['tsvgx', 12:45:36 INFO - 'tsvgr_opacity', 12:45:36 INFO - 'tart', 12:45:36 INFO - 'tscrollx', 12:45:36 INFO - 'cart']}, 12:45:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['tsvgx', 12:45:36 INFO - 'tsvgr_opacity', 12:45:36 INFO - 'tart', 12:45:36 INFO - 'tscrollx', 12:45:36 INFO - 'cart']}, 12:45:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'tests': ['tp5o']}, 12:45:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'talos_options': ['--e10s'], 12:45:36 INFO - 'tests': ['tp5o']}, 12:45:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'talos_options': ['--xperf_path', 12:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:36 INFO - 'tests': ['tp5n']}, 12:45:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:36 INFO - 'talos_options': ['--e10s', 12:45:36 INFO - '--xperf_path', 12:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:36 INFO - 'tests': ['tp5n']}}, 12:45:36 INFO - 'talos.zip': {'path': '', 12:45:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:36 INFO - Running post-action listener: _resource_record_post_action 12:45:36 INFO - ##### 12:45:36 INFO - ##### Running create-virtualenv step. 12:45:36 INFO - ##### 12:45:36 INFO - Running pre-action listener: _resource_record_pre_action 12:45:36 INFO - Running main action method: create_virtualenv 12:45:36 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:45:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:36 INFO - Using real prefix '/tools/python27' 12:45:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:40 INFO - Installing pip.................done. 12:45:40 INFO - Return code: 0 12:45:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 12:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 12:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:40 INFO - 'HOME': '/Users/cltbld', 12:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:40 INFO - 'LOGNAME': 'cltbld', 12:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:40 INFO - 'MOZ_NO_REMOTE': '1', 12:45:40 INFO - 'NO_EM_RESTART': '1', 12:45:40 INFO - 'PAGER': '/bin/cat', 12:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:40 INFO - 'PWD': '/builds/slave/test', 12:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:40 INFO - 'SHELL': '/bin/bash', 12:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:45:40 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:40 INFO - 'USER': 'cltbld', 12:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:40 INFO - 'XPC_FLAGS': '0x0', 12:45:40 INFO - 'XPC_SERVICE_NAME': '0', 12:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:40 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 12:45:40 INFO - Cleaning up... 12:45:40 INFO - Return code: 0 12:45:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 12:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 12:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:40 INFO - 'HOME': '/Users/cltbld', 12:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:40 INFO - 'LOGNAME': 'cltbld', 12:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:40 INFO - 'MOZ_NO_REMOTE': '1', 12:45:40 INFO - 'NO_EM_RESTART': '1', 12:45:40 INFO - 'PAGER': '/bin/cat', 12:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:40 INFO - 'PWD': '/builds/slave/test', 12:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:40 INFO - 'SHELL': '/bin/bash', 12:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:45:40 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:40 INFO - 'USER': 'cltbld', 12:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:40 INFO - 'XPC_FLAGS': '0x0', 12:45:40 INFO - 'XPC_SERVICE_NAME': '0', 12:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:41 INFO - Downloading/unpacking psutil>=0.7.1 12:45:41 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 12:45:41 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 12:45:41 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 12:45:41 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 12:45:41 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 12:45:41 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 12:45:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:45:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:45:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:43 INFO - Installing collected packages: psutil 12:45:43 INFO - Running setup.py install for psutil 12:45:43 INFO - building 'psutil._psutil_osx' extension 12:45:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:45:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:45:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:45:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:45:44 INFO - building 'psutil._psutil_posix' extension 12:45:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:45:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:45:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:45:44 INFO - ^ 12:45:44 INFO - 1 warning generated. 12:45:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:45:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:44 INFO - Successfully installed psutil 12:45:44 INFO - Cleaning up... 12:45:44 INFO - Return code: 0 12:45:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 12:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 12:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:44 INFO - 'HOME': '/Users/cltbld', 12:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:44 INFO - 'LOGNAME': 'cltbld', 12:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:44 INFO - 'MOZ_NO_REMOTE': '1', 12:45:44 INFO - 'NO_EM_RESTART': '1', 12:45:44 INFO - 'PAGER': '/bin/cat', 12:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:44 INFO - 'PWD': '/builds/slave/test', 12:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:44 INFO - 'SHELL': '/bin/bash', 12:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:45:44 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:44 INFO - 'USER': 'cltbld', 12:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:44 INFO - 'XPC_FLAGS': '0x0', 12:45:44 INFO - 'XPC_SERVICE_NAME': '0', 12:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:45:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:45:47 INFO - Installing collected packages: mozsystemmonitor 12:45:47 INFO - Running setup.py install for mozsystemmonitor 12:45:47 INFO - Successfully installed mozsystemmonitor 12:45:47 INFO - Cleaning up... 12:45:47 INFO - Return code: 0 12:45:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:45:47 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')]} 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 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')]} 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/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/build 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/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 12:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:47 INFO - 'HOME': '/Users/cltbld', 12:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:47 INFO - 'LOGNAME': 'cltbld', 12:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:47 INFO - 'MOZ_NO_REMOTE': '1', 12:45:47 INFO - 'NO_EM_RESTART': '1', 12:45:47 INFO - 'PAGER': '/bin/cat', 12:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:47 INFO - 'PWD': '/builds/slave/test', 12:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:47 INFO - 'SHELL': '/bin/bash', 12:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:45:47 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:47 INFO - 'USER': 'cltbld', 12:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:47 INFO - 'XPC_FLAGS': '0x0', 12:45:47 INFO - 'XPC_SERVICE_NAME': '0', 12:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 INFO - Downloading/unpacking blobuploader==1.2.4 12:45:47 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 12:45:47 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 12:45:47 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 12:45:47 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 12:45:47 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 12:45:47 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 12:45:49 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:45:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:51 INFO - Downloading docopt-0.6.1.tar.gz 12:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:51 INFO - Running setup.py install for blobuploader 12:45:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:45:51 INFO - Running setup.py install for requests 12:45:52 INFO - Running setup.py install for docopt 12:45:52 INFO - Successfully installed blobuploader requests docopt 12:45:52 INFO - Cleaning up... 12:45:52 INFO - Return code: 0 12:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:52 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')]} 12:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:52 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')]} 12:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 12:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 12:45:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:45:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:52 INFO - 'HOME': '/Users/cltbld', 12:45:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:52 INFO - 'LOGNAME': 'cltbld', 12:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:52 INFO - 'MOZ_NO_REMOTE': '1', 12:45:52 INFO - 'NO_EM_RESTART': '1', 12:45:52 INFO - 'PAGER': '/bin/cat', 12:45:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:52 INFO - 'PWD': '/builds/slave/test', 12:45:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:52 INFO - 'SHELL': '/bin/bash', 12:45:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:45:52 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:45:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:52 INFO - 'USER': 'cltbld', 12:45:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:52 INFO - 'XPC_FLAGS': '0x0', 12:45:52 INFO - 'XPC_SERVICE_NAME': '0', 12:45:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:52 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Rp5SLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:52 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-dSu7WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:52 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Rjc41j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:52 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-afTUiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-RVm4vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-fLWFJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-UYG80t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-zEC0pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-8v9WpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-YawY_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-M9VuNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:53 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-zuFiud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:54 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-2yJiIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:54 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-hWcMbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:54 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-5ra3qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:54 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-stQSqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:54 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-MdjfXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:45:54 INFO - Running setup.py install for manifestparser 12:45:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:45:54 INFO - Running setup.py install for mozcrash 12:45:54 INFO - Running setup.py install for mozdebug 12:45:55 INFO - Running setup.py install for mozdevice 12:45:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Running setup.py install for mozfile 12:45:55 INFO - Running setup.py install for mozhttpd 12:45:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Running setup.py install for mozinfo 12:45:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Running setup.py install for mozInstall 12:45:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:45:55 INFO - Running setup.py install for mozleak 12:45:56 INFO - Running setup.py install for mozlog 12:45:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:45:56 INFO - Running setup.py install for moznetwork 12:45:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:45:56 INFO - Running setup.py install for mozprocess 12:45:56 INFO - Running setup.py install for mozprofile 12:45:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:45:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:45:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:45:56 INFO - Running setup.py install for mozrunner 12:45:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:45:56 INFO - Running setup.py install for mozscreenshot 12:45:57 INFO - Running setup.py install for moztest 12:45:57 INFO - Running setup.py install for mozversion 12:45:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:45:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:45:57 INFO - Cleaning up... 12:45:57 INFO - Return code: 0 12:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:57 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')]} 12:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:57 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')]} 12:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 12:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 12:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:57 INFO - 'HOME': '/Users/cltbld', 12:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:57 INFO - 'LOGNAME': 'cltbld', 12:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:57 INFO - 'MOZ_NO_REMOTE': '1', 12:45:57 INFO - 'NO_EM_RESTART': '1', 12:45:57 INFO - 'PAGER': '/bin/cat', 12:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:57 INFO - 'PWD': '/builds/slave/test', 12:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:57 INFO - 'SHELL': '/bin/bash', 12:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:45:57 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:57 INFO - 'USER': 'cltbld', 12:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:57 INFO - 'XPC_FLAGS': '0x0', 12:45:57 INFO - 'XPC_SERVICE_NAME': '0', 12:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:57 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-kgNBD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:57 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Q1S9hT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:57 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-pksR_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-d20nUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-6x3jnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-5QncXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-oBAx7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-b7KWOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-PpInRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-NwjpmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:58 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-i6ATP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:59 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-QcskYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:59 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-qHtNVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:59 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-BNOuZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:59 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Dv9qwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:59 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-_32adq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:59 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-4GtJIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:45:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:59 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 12:45:59 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 12:45:59 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 12:45:59 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 12:45:59 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 12:45:59 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 12:46:02 INFO - Downloading blessings-1.5.1.tar.gz 12:46:02 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:46:02 INFO - Installing collected packages: blessings 12:46:02 INFO - Running setup.py install for blessings 12:46:02 INFO - Successfully installed blessings 12:46:02 INFO - Cleaning up... 12:46:02 INFO - Return code: 0 12:46:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:02 INFO - Reading from file tmpfile_stdout 12:46:02 INFO - Current package versions: 12:46:02 INFO - blessings == 1.5.1 12:46:02 INFO - blobuploader == 1.2.4 12:46:02 INFO - docopt == 0.6.1 12:46:02 INFO - manifestparser == 1.1 12:46:02 INFO - mozInstall == 1.12 12:46:02 INFO - mozcrash == 0.16 12:46:02 INFO - mozdebug == 0.1 12:46:02 INFO - mozdevice == 0.47 12:46:02 INFO - mozfile == 1.2 12:46:02 INFO - mozhttpd == 0.7 12:46:02 INFO - mozinfo == 0.9 12:46:02 INFO - mozleak == 0.1 12:46:02 INFO - mozlog == 3.0 12:46:02 INFO - moznetwork == 0.27 12:46:02 INFO - mozprocess == 0.22 12:46:02 INFO - mozprofile == 0.27 12:46:02 INFO - mozrunner == 6.11 12:46:02 INFO - mozscreenshot == 0.1 12:46:02 INFO - mozsystemmonitor == 0.0 12:46:02 INFO - moztest == 0.7 12:46:02 INFO - mozversion == 1.4 12:46:02 INFO - psutil == 3.1.1 12:46:02 INFO - requests == 1.2.3 12:46:02 INFO - wsgiref == 0.1.2 12:46:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x108cf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde3bca9fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 12:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 12:46:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:46:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:02 INFO - 'HOME': '/Users/cltbld', 12:46:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:02 INFO - 'LOGNAME': 'cltbld', 12:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:02 INFO - 'MOZ_NO_REMOTE': '1', 12:46:02 INFO - 'NO_EM_RESTART': '1', 12:46:02 INFO - 'PAGER': '/bin/cat', 12:46:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:02 INFO - 'PWD': '/builds/slave/test', 12:46:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:02 INFO - 'SHELL': '/bin/bash', 12:46:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:46:02 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:46:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:02 INFO - 'USER': 'cltbld', 12:46:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:02 INFO - 'XPC_FLAGS': '0x0', 12:46:02 INFO - 'XPC_SERVICE_NAME': '0', 12:46:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:46:03 INFO - Cleaning up... 12:46:03 INFO - Return code: 0 12:46:03 INFO - Running post-action listener: _resource_record_post_action 12:46:03 INFO - Running post-action listener: _start_resource_monitoring 12:46:03 INFO - Starting resource monitoring. 12:46:03 INFO - ##### 12:46:03 INFO - ##### Running install step. 12:46:03 INFO - ##### 12:46:03 INFO - Running pre-action listener: _resource_record_pre_action 12:46:03 INFO - Running main action method: install 12:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:03 INFO - Reading from file tmpfile_stdout 12:46:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:46:03 INFO - Reading from file tmpfile_stdout 12:46:03 INFO - Output received: 12:46:03 INFO - Usage: mozinstall [options] installer 12:46:03 INFO - Options: 12:46:03 INFO - -h, --help show this help message and exit 12:46:03 INFO - -d DEST, --destination=DEST 12:46:03 INFO - Directory to install application into. [default: 12:46:03 INFO - "/builds/slave/test"] 12:46:03 INFO - --app=APP Application being installed. [default: firefox] 12:46:03 INFO - mkdir: /builds/slave/test/build/application 12:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:46:38 INFO - Reading from file tmpfile_stdout 12:46:38 INFO - Output received: 12:46:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:46:38 INFO - Running post-action listener: _resource_record_post_action 12:46:38 INFO - ##### 12:46:38 INFO - ##### Running run-tests step. 12:46:38 INFO - ##### 12:46:38 INFO - Running pre-action listener: _resource_record_pre_action 12:46:38 INFO - Running main action method: run_tests 12:46:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:46:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:46:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:46:38 INFO - 2015-11-09 12:46:38.889 screenresolution[1913:14830] starting screenresolution argv=screenresolution get 12:46:38 INFO - 2015-11-09 12:46:38.892 screenresolution[1913:14830] Display 0: 1600x1200x32@60 12:46:38 INFO - 2015-11-09 12:46:38.899 screenresolution[1914:14832] starting screenresolution argv=screenresolution list 12:46:38 INFO - Available Modes on Display 0 12:46:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:46:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:46:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:46:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:46:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:46:39 INFO - Intel HD Graphics 3000: 12:46:39 INFO - Chipset Model: Intel HD Graphics 3000 12:46:39 INFO - Type: GPU 12:46:39 INFO - Bus: Built-In 12:46:39 INFO - VRAM (Total): 512 MB 12:46:39 INFO - VRAM (Dynamic, Max): 10 12:46:39 INFO - Vendor: Intel (0x8086) 12:46:39 INFO - Device ID: 0x0116 12:46:39 INFO - Revision ID: 0x0009 12:46:39 INFO - Displays: 12:46:39 INFO - Display: 12:46:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:46:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:46:39 INFO - Display Serial Number: 1600x1200 60 12:46:39 INFO - Main Display: Yes 12:46:39 INFO - Mirror: Off 12:46:39 INFO - Online: Yes 12:46:39 INFO - Rotation: Supported 12:46:39 INFO - Return code: 0 12:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:39 INFO - Python 2.7.3 12:46:39 INFO - Return code: 0 12:46:39 INFO - grabbing minidump binary from tooltool 12:46:39 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')]} 12:46:39 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/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca59f0>, '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 0x108a04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c6f990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:46:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:46:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:39 INFO - Return code: 0 12:46:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:46:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:46:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] in /builds/slave/test/build 12:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0049 --webServer localhost 12:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wma7AR9S45/Render', 12:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:39 INFO - 'HOME': '/Users/cltbld', 12:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:39 INFO - 'LOGNAME': 'cltbld', 12:46:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:39 INFO - 'MOZ_NO_REMOTE': '1', 12:46:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:39 INFO - 'NO_EM_RESTART': '1', 12:46:39 INFO - 'PAGER': '/bin/cat', 12:46:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:39 INFO - 'PWD': '/builds/slave/test', 12:46:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:39 INFO - 'SHELL': '/bin/bash', 12:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners', 12:46:39 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 12:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:39 INFO - 'USER': 'cltbld', 12:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:39 INFO - 'XPC_FLAGS': '0x0', 12:46:39 INFO - 'XPC_SERVICE_NAME': '0', 12:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:46:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] with output_timeout 3600 12:46:39 INFO - mozversion INFO | application_buildid: 20151109111239 12:46:39 INFO - mozversion INFO | application_changeset: 67fbffadaa47af2ba4d397f34f6c07e909bf0d6e 12:46:39 INFO - mozversion INFO | application_display_name: Nightly 12:46:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:39 INFO - mozversion INFO | application_name: Firefox 12:46:39 INFO - mozversion INFO | application_remotingname: firefox 12:46:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:46:39 INFO - mozversion INFO | application_vendor: Mozilla 12:46:39 INFO - mozversion INFO | application_version: 45.0a1 12:46:39 INFO - mozversion INFO | platform_buildid: 20151109111239 12:46:39 INFO - mozversion INFO | platform_changeset: 67fbffadaa47af2ba4d397f34f6c07e909bf0d6e 12:46:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:46:39 INFO - mozversion INFO | platform_version: 45.0a1 12:46:39 INFO - 2015-11-09 12:46:39,481 DEBUG : using testdate: 1447101999 12:46:39 INFO - 2015-11-09 12:46:39,481 DEBUG : actual date: 1447101999 12:46:39 INFO - 2015-11-09 12:46:39,495 INFO : starting webserver on 'localhost:54245' 12:46:39 INFO - 2015-11-09 12:46:39,496 INFO : Starting test suite t-yosemite-r5-0049 12:46:39 INFO - 2015-11-09 12:46:39,496 INFO : Starting test dromaeo_css 12:46:39 INFO - 2015-11-09 12:46:39,496 DEBUG : operating with platform_type : mac_ 12:46:39 INFO - 2015-11-09 12:46:39,497 INFO : Initialising browser for dromaeo_css test... 12:46:39 INFO - 2015-11-09 12:46:39,510 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpPQGBey/profile http://localhost:54245/getInfo.html 12:46:42 INFO - 2015-11-09 12:46:42,409 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:46:42 INFO - 2015-11-09 12:46:42,409 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:46:42 INFO - 2015-11-09 12:46:42,410 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:46:42 INFO - 2015-11-09 12:46:42,410 DEBUG : BROWSER_OUTPUT: __metrics 12:46:42 INFO - 2015-11-09 12:46:42,427 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:43 INFO - 2015-11-09 12:46:43,116 INFO : Browser initialized. 12:46:43 INFO - 2015-11-09 12:46:43,116 INFO : Running cycle 1/1 for dromaeo_css test... 12:46:43 INFO - 2015-11-09 12:46:43,116 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpPQGBey/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:46:55 INFO - 2015-11-09 12:46:55,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 227680256 12:46:55 INFO - 2015-11-09 12:46:55,148 DEBUG : BROWSER_OUTPUT: 12:47:46 INFO - 2015-11-09 12:47:46,027 DEBUG : BROWSER_OUTPUT: 1447102066020 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] 12:49:57 INFO - 2015-11-09 12:49:57,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54245/tests/dromaeo/cssquery-ext.html) 12:49:58 INFO - 2015-11-09 12:49:58,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 340664320 12:49:58 INFO - 2015-11-09 12:49:58,395 DEBUG : BROWSER_OUTPUT: 12:53:01 INFO - 2015-11-09 12:53:01,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/dromaeo/cssquery-ext.html (next: http://localhost:54245/tests/dromaeo/cssquery-jquery.html) 12:53:01 INFO - 2015-11-09 12:53:01,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 365096960 12:53:01 INFO - 2015-11-09 12:53:01,693 DEBUG : BROWSER_OUTPUT: 12:56:03 INFO - 2015-11-09 12:56:03,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54245/tests/dromaeo/cssquery-mootools.html) 12:56:04 INFO - 2015-11-09 12:56:04,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 348688384 12:56:04 INFO - 2015-11-09 12:56:04,449 DEBUG : BROWSER_OUTPUT: 12:59:06 INFO - 2015-11-09 12:59:06,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54245/tests/dromaeo/cssquery-prototype.html) 12:59:07 INFO - 2015-11-09 12:59:07,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 329863168 12:59:07 INFO - 2015-11-09 12:59:07,082 DEBUG : BROWSER_OUTPUT: 13:02:10 INFO - 2015-11-09 13:02:10,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54245/tests/dromaeo/cssquery-yui.html) 13:02:10 INFO - 2015-11-09 13:02:10,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 320045056 13:02:10 INFO - 2015-11-09 13:02:10,770 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/dromaeo/cssquery-yui.html (next: http://localhost:54245/tests/dromaeo/cssquery-dojo.html) 13:05:13 INFO - 2015-11-09 13:05:13,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 378437632 13:05:13 INFO - 2015-11-09 13:05:13,838 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,838 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:05:13 INFO - 2015-11-09 13:05:13,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:05:13 INFO - 2015-11-09 13:05:13,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:05:13 INFO - 2015-11-09 13:05:13,839 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:05:13 INFO - 2015-11-09 13:05:13,840 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3130.2174456385906;3201.119692084678;3234.029791062682;3237.465818140007;3255.7232635225996;5211.947880521194;5323.467653234675;5350.0904846176145;5406.351237851459;5476.945230547693;5311.309529761135;5341.1187154119525;5348.090824559825;5360.892782144355;5475.6440831345935;4985.501449855004;5020.272060551218;5029.874253143683;5038.370203724535;5080.110980578403;5155.968806238749;5177.275181474596;5191.792328306882;5210.2445145453885;5239.161734122541;4875.171220892421;4955.281484184773;4991.675541089818;5002.699838009731;5127.487251274899;5021.246812978046;5038.496150384969;5053.267276244924;5068.366454193226;5074.949250507485;5004.5495905368325;5012.8997420051755;5018.77415516299;5026.949730502722;5059.367579052619;5137.6660517066275;5230.607704422184;5230.947690523122;5260.710660913648;5308.654937429054;5689.146628005791;5690.459406356389;5709.543236541067;5731.512821410185;5768.307803063659;5740.253767010304;5752.36723960364;5759.366469688331;5764.481196692318;5778.682172480512;5161.66449180802;5251.10731175701;5251.501107394792;5253.40295354441;5407.972960135214;5846.269216347957;5857.4435428634215;5872.588918775645;5874.265716785402;5894.646321220741;5646.35066967304;5655.1517272409465;5659.603827732101;5680.744366503517;5710.571707121982;5606.159076138611;5632.464915832989;5722.656640601577;5733.082706766981;5783.1325301204315;5664.49019588239;5678.488935995781;5683.175939488834;5691.345495268014;5699.487046165865;5672.205891175238;5692.715364231772;5711.286089238845;5718.571107166979;5726.656400615976;4348.195583816941;4463.330500424962;4463.754493502888;4468.664850136252;4493.28107502798;4012.6589239914933;4043.6562892153906;4060.3097473428998;4106.548279689232;4123.340265557496;5259;5295.179247216687;5310.575153987672;5312.5218730314455;5349.251104845324;5551.583631227674;5719.456651618089;5732.971335143381;5748.13777933305;5773.624714393551;5201.45384734605;5253.50091741284;5282.154855223146;5288.629795914326;5314.335708036496;5019.573336266385;5061.9746901266;5071.061853557104;5071.340725705634;5134.870328527718;5687.289088863892;5871.324797648325;5874.471297583238;5892.705364731832;5939.792107276311;5654.6324488908085;5682.6306290091015;5716.342620598684;5761.711914404179;5824.097264923944;5898.262717160355;5906.936751384792;5914.053751399928;5918.881622367615;5929.61457505278;5489.258950041693;5712.0860662293835;5716.485516303386;5718.485336319751;5723.198752174782;5411.83764487066;5429.864253393696;5627.549796016391;5657.519110875457;5766.250387449605;5490.670559766427;5602.13166959122;5623.578231632562;5638.577106716931;5694.772209111589;5381.973090134525;5596.776128954796;5624.128260119688;5626.071698169756;5650.434956504317;5409.810656626999;5443.918341224806;5475.452454754652;5494.587905906993;5540.445955404427;5641.323041235078;5665.886682266414;5685.005124103182;5685.77256909719;5697.886042279214;5181.740912954413;5550.611457197957;5553.972230138824;5569.08110161835;5575.7490912909825 13:05:13 INFO - 2015-11-09 13:05:13,844 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.2875490617101;555.2725929032966;570.1988705868255;571.5884563114558;576.5358886096691;30639.846800765994;31676.366472670532;37894.62105378945;38587.61412385875;38646.613533864656;40880.59119408805;41000.38499422504;41298.380524292086;41398.17203655925;41403.17193656125;8192.016957965052;8354.206350396702;8845.513496757692;9089.727308180765;9096.54517274137;10815.134789216883;11229.7192570186;11252.212345135844;11257.493412796402;11265.042471389941;10888.836667449994;10992.120630349593;11039.116870650369;11048.779024419508;11103.500342484567;8486.448380855225;8632.007319158252;10895.564177432932;11008;11340.092792576574;10686.465676716132;10989.395583242918;10990.505427255714;10991.725206869813;11028.338299702044;38718.80640596807;39329.213415731814;39346;39409.80295098506;39471;2758.1036163246827;2810.269329974201;2897.797154199207;3000.9849950750327;3322.90031299059;26126.738732612812;26648.733512665014;28036.85981570079;28953.85523072371;29408.41183176346;2367.656689779972;2408.7952524035477;2435.683361163055;2442.2673198040693;2454.7667971542674;266126;267052;268315;268561.65719171474;269070.999999998;57341.42658573444;58025.41974580284;60788;61277;66570.66714666395;60615.69692151511;61539.692301538205;61935;61959.56485221802;61988;16553.66892662164;16734.4142954996;16748.832511674726;16750.162491875602;16755.2460139294;12700.682482938;12760.234385936874;12763.744725105631;12784.552540661032;12789.424475898606;19562.90218548898;19952;19983.800161998486;20079.498012549804;20109.19563217484;8198.180181981754;8420.326373890073;8428.957855210685;8440.746777596682;8489.830203395897;920.9033051529493;945.7966537194399;1037.8479887325063;1050.495762034228;1131.2477202660302;27395.90416383362;27667.861660691568;28036.71963280382;28167.859160704065;28224.29439264035;994.5524513968743;1036.9377837329785;1057.2176589323844;1098.1653943003375;1141.1156353825852;14458.421663133568;14621.529401231619;14659.633509162357;14810.407583696531;14846.777298340534;298194;305775;306001;306334;307145;53407.46592534025;53998.46001540013;54005.45994540083;54215.72892135514;54237;1323.894088472939;1342.9731405372033;1343.6439343573961;1354.2010213973606;1364.433759989613;27446.725532744418;28167.859160704884;28180.43639127165;31060;31102.68897310998;51743;52151.47848521466;52577.21134183067;52654.47345526495;52664.47335526596;271332;276441;276606;276733;277305;34557.481637775956;35186;41592.792036039624;45331.773341133085;45968;42875.57124428716;43073.7846310779;43078.78460607677;43193;43724.56275437332;35550.64449355473;35801.82099089488;36077.639223607424;36404.27191456209;36798.63201367952;30836.832633472946;35400.645993539736;35712;36303.755526502595;39012.41481377725;34318.48522272218;35489.46765798567;35990.82004590065;36030;36043.09892252715;29523.704762952097;31613.367732644758;31724.524132137576;31810.363792723554;31823.363532728752;23594.882025589763;23697.881510592335;23785.52428951446;23813.52372952566;23838.404039899142 13:05:13 INFO - 2015-11-09 13:05:13,845 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.50218427818953;337.72306708499025;339.9796012239266;341.0943943829134;344.24610103872527;14275.2862356882;14740.115593064396;17562.64874702507;17928.28286868525;19077.71383429248;14342.856571434282;14497.49258775943;15553.611159721013;15983.360665573364;17977.460676179704;5351.598630102748;5460.372057213432;5522.972385138089;5531.834044978637;5534.363548191969;3829.6936245100464;4003.339448990913;5250.6587071840395;5444.591655625824;5449.863753406157;5775.682337471438;5896.321922978848;5945.791897283596;5957.85105372367;5959.851003724898;5750.1949727038245;5922.822315330547;5968.283805943314;5969.731362088738;5984.371640977722;5115.641905066647;5162;5162.870928226786;5163.277141200235;5171.50870667286;20600.38198854037;20634.48413789652;20982.895085524626;21478.677819832716;21539.8923005384;1909.6180763847285;1958.9314373996842;1970.6945423459388;2020.8888511131881;2226.365485836529;12939.48242070316;13015.284159371231;13074.411651475706;13173.077884548085;13285.933570332087;1626.0731383111631;1630.184907546227;1651.5474520337289;1685.9831401686072;1706.8122506524273;54000.189997150075;54546.9999999996;54801.725991370186;54805.1779223312;54896;9192.126747959066;9362.859557106649;9528.857067143997;9587.760305992406;9680.177184939359;11613.535458581562;11638.243514171721;11639.76720465586;11668.474918628683;11727.179097463095;7418.443616728767;7695.846083078307;7885.802854928673;7970.043594768665;8048.5170889746805;8148.144444833207;8154.3884208684585;8161.387895907831;8247.175282471704;8282.503049816909;5591.356993945748;5676.7161641918565;5685.6304340218585;5700.543956483471;5760.607449628353;1526.4809964612086;1593.9043657380594;1615.878809089323;1649.150687395992;1650.6698660267755;941.5339406993583;948.6158105966956;980.9901900980899;985.2265971212564;1038.1383451735041;17653;18068.457946261635;18253.726194107097;18516;18725.109555432125;824.7135859142985;923.0907556057278;951.2390087929629;958.3866325551653;970.46624356605;9759.658411955548;10054.748631284276;10110.69667909964;10123.7469063274;10170.491475426199;530793;536458;543279;553627;570309.3360798775;65118.674406627666;65501;66835.66582167058;67380.34194441518;68118.65940670265;1119.6081371519904;1130.9151813613848;1172.5251273234353;1200.3578085724096;1213.3751118174148;15680.372785088925;15933.521994340188;16022.519324420286;16151.434699785452;16452.588685282484;32359.191020224684;32975.576607906856;33220.1694957628;33575.66424335823;33625.83187084049;45088.323675145555;45270.18919243325;45270.54729452663;45277.320840188084;46036;8984.23633991118;9141.085891411072;9147.496887670975;9153.725388238363;9171.862422063808;17736.11319434049;17812.376566820098;18521.07394630236;18653.347132850286;18722.25110995545;11787.11596630239;13193;14075.648108797363;14085;14488.637784055483;13467.259300738553;13559.254241016444;13633;13837.30813459303;14225.14649121056;14120.223387713775;14150.78773818373;14349.426022958965;14633.634159146106;14735.26323683833;8882.60028298741;8904.55477226149;8914.598843052208;8959.596818143069;9062.229710474683;14135.15189088658;14302;14650.047746896418;14855.92572037133;14988.325525351167 13:05:13 INFO - 2015-11-09 13:05:13,847 DEBUG : BROWSER_OUTPUT: |3;mootools.html;912.9269658427327;1669.8413650703183;1759.9560010999724;1767.7348397740338;1799.019534353777;7269.382102521286;7511.661975211115;8055.395845311603;8168.4282100253;8253.257206851382;7939.801504962379;8073.434859559833;8090.514569125857;8098;8184.7953801155;1950.8731932424419;2033.8983050847473;2178.749443813958;2196.9450763730874;2206.9889650551804;2221.7444993825675;2255.672927425522;2262.1856131792624;2264.920727774528;2273.2839155665997;2145.0776166248506;2181.225664888965;2212.4911270407815;2215.645496720525;2219.522802597441;1899.477643647994;1948.9512762180916;2146.924857629991;2189.1571744878256;2198.681191227279;2176.3579743975565;2206.6800313954386;2214.202886960693;2226.4656482444257;2235.1953296813135;8108.702607582817;8182.099969003405;8186.672533098728;8234.588270586506;8262.215089566482;4763.785629646674;4797.784099715486;4798.112349215371;4811.542903424169;4864.610831133501;2893.681695013568;3019.4866872631706;3034.4841376965746;3036.8481575921114;3071.6774738652566;940.8682784410188;944.9102335278207;977.1742877268697;989.7278248481654;1017.6031347774374;10435.217358698128;10513.264071514997;10531.578736850517;10588.258821882471;10637.627683031134;4153.54311025787;4230.386593943923;4273.18809426208;4291.03451723366;4334.544872788375;8708.17272359125;8721.825563488821;8725.171108744658;8752.037275899645;8767.473951562926;4873.122837889214;4873.658843880965;4875.95124048762;4889.511048895082;4945.381827271591;4524;4526.502084770673;4527.61515271199;4558.612517935946;4563.06457176278;3404.4893266010295;3484.6689564491335;3505.6669616386403;3520.507129001942;3528.4707293906117;1028.454918892988;1034.270839058462;1035.4770840725537;1041.9791604167874;1043.7234132954773;1141.9942900285446;1257.4278703190027;1296.8119622654851;1307.6730817295677;1329.335332333833;7646.082470103512;7651.464397492234;7667.424943129287;7668.769936901902;7709.267619576131;461.71373748276284;463.00685030609156;469.3499503188109;469.47887844492584;470.3556128104519;5647.209390685307;5736.799212027559;5764.769409223668;5768.913466297925;5829.183914252008;9340.439573625605;9514.714558563253;9579.856302155473;9581.616735330648;9647.324687271823;9245.768855778659;9439.622415103318;9449.055094490495;9491.288153388385;9539.14147726708;7278.745243916437;7397.334239918326;7420.740274090381;7431.182569917305;7516.060492438445;7169.820754481179;7234.74678386254;7251.891221631574;7266.38235749946;7311.561306321638;8397.328213743009;8521.872171917303;8522.659093636434;8549.829003420022;8560;8648.481091134552;8738.388312818042;8779.297656187617;8805.119488051143;8806.823863522823;6654.401103900672;6726.461883049442;6741.966290168518;6768.255491895789;6803.5712500375475;7652.7704168875025;7713;7748.651310691145;7767.184445633353;7855.60721963888;7204.171520275236;7266.781996540112;7300.634968251672;7370.410367170506;7440.962795185989;6377.489800816016;6640.535162538576;7013.684384202825;7026.9648651756415;7201.567905925452;7210.603416812126;7371.262873712801;7408.592527411044;7456.366208872307;7470.514416562906;5478.91781623284;5491.148871924858;5505.862353441196;5517.69652669107;5569.66582005081;6877.071595334566;6877.552959057645;6894.069300644549;6894.103766510522;6937 13:05:13 INFO - 2015-11-09 13:05:13,851 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.92552250221195;322.7031131359149;325.9641439441661;330.0724962854379;333.6196735721278;6035.094735789634;6090.482309003734;6115.388461153893;6156.969215153924;6159.23009623797;5942.732577034033;5982.521398288138;6025.9096113558335;6038.064100064497;6042.939570604292;4691.929621055679;4743.335932969387;4745.050989802036;4761.50004249554;4771.90456190876;4616.907661846761;4795.328653988445;4809.326694262806;4818.710877347353;4827.806887724487;4719.339292499053;4721.811127554894;4744.549267819569;4774.952250477486;4789.832355867546;4546.272596384596;4722.055588882237;4769.165396055676;4770.76146192689;4792.376990991166;3943.4676318696897;3993.0416699992084;4063.9796801015805;4064.1465292288653;4122.443470131524;5709.229254050691;5833.766649334021;5877.23595932526;5880.7353669085;5898.292204935392;5065.594752419835;5079.187330027178;5194.428612852583;5222.4255331913455;5260.395054568736;6209.782657606962;6241.126242326078;6313.337099604567;6321.778737744157;6323.30443651198;4345.109252603209;4358.36803663467;4362.978185109086;4408.515063343029;4429.092036132585;6393.104965304861;6506.446952009085;6532.608043517404;6581.835454113638;6644;4468.151051300242;4478.305862591238;4498.145352383102;4505.81976720934;4543.045960348298;4542.659300552472;4546.113507866001;4559.019810740707;4573.0396616710195;4589.242774942164;5242.344706911636;5242.947570524246;5259.158534634516;5322.281491998608;5334.946650533522;6233.34549872266;6347.460465860361;6349.650769207646;6421.903671444932;6429.1320671709655;1614.8385161483757;1626.3738460692482;1628.0150508942156;1628.5928517870532;1650.9422170223984;1067.1836045425257;1072.4316112460408;1075.4300220882944;1085.478970094359;1090.86909570852;6035.155078289043;6058.363871793486;6112.358202388774;6122;6148.262208535004;6589.868202636017;6600.86798264032;6650.102236198148;6655.767048153291;6682.79951601443;5938.8218353449465;6057.000594901792;6065.939340606626;6123.38766123393;6132.233470816148;3614.855405783739;3643.4899114124046;3654.470101835219;3689.1883785567134;3707.480952666629;6770.932290677129;6800;6807.795766127024;6834.931650683529;6838.589684618839;6494.935050649433;6734.629595372302;6777.390034896883;6811.046453496514;6839.0425340452375;6327.968360158262;6700;6727.596344219362;6776.085228494188;6786.864262714619;6537.673116344259;6547.345265473415;6598.208215014229;6613.305602911625;6615.933840661532;6419.518536109904;6453.45145662624;6468.5472016958365;6472.8705425890275;6501.707423165874;6531.150950376421;6707.094542236736;6778.762743304158;6904.4131248844415;6939.965300173467;4505.324201369821;4523.163214805271;4525.977370113128;4560.2019646562385;4576.496585375539;6641.538861450473;6658.3674550917585;6733.360330768569;6745.325467453215;6749.3925546699065;6322.336154703874;6359.523035772429;6438.90341644885;6468.482521398371;6473.8705225896165;6361.840953976188;6376.075469057054;6444.871102578016;6456.580322279036;6478.255000674794;6291.930371836707;6302.873942521215;6303.905441418474;6308.463780578702;6342.651154186564;6284.245890492987;6396.648184349905;6402.679866006588;6449.451796597342;6458.61248325102;6371.5221358397375;6384.872302554016;6387.361263873576;6414.711337989708;6430.582012169194 13:05:13 INFO - 2015-11-09 13:05:13,851 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.4695089961574;755.2598453515554;759.5290919629826;775.0157300228706;776.9417293702974;13704.177749335035;14000.159990400583;14003.929980350083;14056.71886562268;14155.292235388228;12708.364581770898;12747.808782868264;12823.294718790463;12867;12925.935370323135;693.972241110355;714.5391222661381;877.5217506458995;895.6417433026809;898.2095755734977;855.8159995600945;870.7344260000697;871.7471933139382;874.6020560644923;877.9517126558037;724.6847621284732;735.4447392218867;936.484933286693;938.6151677812098;946.0444950599909;918.8208299381623;923.3582660051267;924.2328867040374;931.4132096778986;933.4912472702393;690.2372877969822;691.2603514239765;697.8813601687725;698.2040473859804;698.3644883156354;13451.66370840727;13590.524331648443;13635.454581816715;13718.314084295846;13780.379882905294;11510.366929818856;11926;11930.164888457724;12014;12117.636470905887;9269.397489163182;9291.674791382336;9386.530673466299;9498.905010949871;9886.851697224547;3241.7406607471344;3336.366090442808;3374.3420033093557;3393.6606339366112;3410.9658903410896;46125.07749845018;46585.068298633836;46613.30080048802;46707.76646116748;46899.29651055237;8720.171583699539;9003.279737620975;9030.232430243372;9122.86315705265;9667.516624168764;19246.90376548108;19371;19419.029048547516;19429;19557.43540516784;7037.366637002592;7044.049053377728;7112.146542414944;7179.210286868441;7282.526635768658;3764.3036038333;3768.474006161699;3816.656500914931;3849.9807500962875;3883.9029024274055;2969.391274788706;2978.5829983802287;2984.805987610798;2987.4323878463024;3022;418.8554948542748;422.7463521886905;424.5330136849503;428.4194915888988;430.6232046958911;536.1716148550499;578.9392113828071;584.2959234122872;601.9819405417844;614.7694614519555;7532.924670753222;7918.564478953597;7976.800579985431;8000.199980002069;8119.147489513634;511.1463855361555;577.9913301300484;596.3708287756372;600.5495878091432;658.706875440434;3571.8392672329805;3602.8558857645926;3933.8033098344968;3997.900052498711;3998.140399814054;49110.26334604984;49801.25298120531;49969.75015124901;50080.749596251786;50225.24662130071;47913.76043119762;48566.27150592744;49432.75283623559;49495.50504494981;49547.752261238464;43580.346294805604;43682.563174368486;43808.78095609565;45621.5437845624;45708;8238.711645092393;8346.415750897379;8346.457480263764;8406.747797566082;8572.614232359683;34288;34565.48151777776;34930.47604285887;35176.296474070885;35216;41343.173136537705;41403;43658.126837462434;44375.11249774922;44910.10179796451;7446.925530744623;7586.127595326388;7605.771826845204;7678.884816727642;7794.415418843496;10800;11025.17311201647;11037.282576632493;11233.438328083399;11618.825717614412;10073.163710005787;10134.6452874152;10187.541560629641;10688.625898093529;10908.945455272673;10355;10566.577336906437;10716.410597417216;10764.300320479144;11147.777044459228;9555.474448905377;9710.902890971;10478.580856765644;10587.576496940035;10648.201384896009;8122.7157049502985;8743.737687869374;8823.823523529622;9001.819963600823;9111.635534578543;7996;8480.872786908325;8884.86672699923;8893.73318800437;9129.360944733804 13:05:13 INFO - 2015-11-09 13:05:13,851 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:05:13 INFO - 2015-11-09 13:05:13,851 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,991 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: __startTimestamp1447103113837__endTimestamp 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:05:13 INFO - 2015-11-09 13:05:13,852 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,853 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5341.07 Median:5489.26 stddev:552.07 (10.1%) stddev-sans-first:525.81 13:05:13 INFO - 2015-11-09 13:05:13,853 DEBUG : BROWSER_OUTPUT: Values: 3130.2 3201.1 3234.0 3237.5 3255.7 5211.9 5323.5 5350.1 5406.4 5476.9 5311.3 5341.1 5348.1 5360.9 5475.6 4985.5 5020.3 5029.9 5038.4 5080.1 5156.0 5177.3 5191.8 5210.2 5239.2 4875.2 4955.3 4991.7 5002.7 5127.5 5021.2 5038.5 5053.3 5068.4 5074.9 5004.5 5012.9 5018.8 5026.9 5059.4 5137.7 5230.6 5230.9 5260.7 5308.7 5689.1 5690.5 5709.5 5731.5 5768.3 5740.3 5752.4 5759.4 5764.5 5778.7 5161.7 5251.1 5251.5 5253.4 5408.0 5846.3 5857.4 5872.6 5874.3 5894.6 5646.4 5655.2 5659.6 5680.7 5710.6 5606.2 5632.5 5722.7 5733.1 5783.1 5664.5 5678.5 5683.2 5691.3 5699.5 5672.2 5692.7 5711.3 5718.6 5726.7 4348.2 4463.3 4463.8 4468.7 4493.3 4012.7 4043.7 4060.3 4106.5 4123.3 5259.0 5295.2 5310.6 5312.5 5349.3 5551.6 5719.5 5733.0 5748.1 5773.6 5201.5 5253.5 5282.2 5288.6 5314.3 5019.6 5062.0 5071.1 5071.3 5134.9 5687.3 5871.3 5874.5 5892.7 5939.8 5654.6 5682.6 5716.3 5761.7 5824.1 5898.3 5906.9 5914.1 5918.9 5929.6 5489.3 5712.1 5716.5 5718.5 5723.2 5411.8 5429.9 5627.5 5657.5 5766.3 5490.7 5602.1 5623.6 5638.6 5694.8 5382.0 5596.8 5624.1 5626.1 5650.4 5409.8 5443.9 5475.5 5494.6 5540.4 5641.3 5665.9 5685.0 5685.8 5697.9 5181.7 5550.6 5554.0 5569.1 5575.7 13:05:13 INFO - 2015-11-09 13:05:13,853 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,854 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46041.00 Median:306167.50 stddev:73793.86 (24.1%) stddev-sans-first:73921.83 13:05:13 INFO - 2015-11-09 13:05:13,855 DEBUG : BROWSER_OUTPUT: Values: 552.3 555.3 570.2 571.6 576.5 30639.8 31676.4 37894.6 38587.6 38646.6 40880.6 41000.4 41298.4 41398.2 41403.2 8192.0 8354.2 8845.5 9089.7 9096.5 10815.1 11229.7 11252.2 11257.5 11265.0 10888.8 10992.1 11039.1 11048.8 11103.5 8486.4 8632.0 10895.6 11008.0 11340.1 10686.5 10989.4 10990.5 10991.7 11028.3 38718.8 39329.2 39346.0 39409.8 39471.0 2758.1 2810.3 2897.8 3001.0 3322.9 26126.7 26648.7 28036.9 28953.9 29408.4 2367.7 2408.8 2435.7 2442.3 2454.8 266126.0 267052.0 268315.0 268561.7 269071.0 57341.4 58025.4 60788.0 61277.0 66570.7 60615.7 61539.7 61935.0 61959.6 61988.0 16553.7 16734.4 16748.8 16750.2 16755.2 12700.7 12760.2 12763.7 12784.6 12789.4 19562.9 19952.0 19983.8 20079.5 20109.2 8198.2 8420.3 8429.0 8440.7 8489.8 920.9 945.8 1037.8 1050.5 1131.2 27395.9 27667.9 28036.7 28167.9 28224.3 994.6 1036.9 1057.2 1098.2 1141.1 14458.4 14621.5 14659.6 14810.4 14846.8 298194.0 305775.0 306001.0 306334.0 307145.0 53407.5 53998.5 54005.5 54215.7 54237.0 1323.9 1343.0 1343.6 1354.2 1364.4 27446.7 28167.9 28180.4 31060.0 31102.7 51743.0 52151.5 52577.2 52654.5 52664.5 271332.0 276441.0 276606.0 276733.0 277305.0 34557.5 35186.0 41592.8 45331.8 45968.0 42875.6 43073.8 43078.8 43193.0 43724.6 35550.6 35801.8 36077.6 36404.3 36798.6 30836.8 35400.6 35712.0 36303.8 39012.4 34318.5 35489.5 35990.8 36030.0 36043.1 29523.7 31613.4 31724.5 31810.4 31823.4 23594.9 23697.9 23785.5 23813.5 23838.4 13:05:13 INFO - 2015-11-09 13:05:13,855 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,855 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28579.90 Median:337.61 stddev:89088.45 (26387.8%) stddev-sans-first:89313.12 13:05:13 INFO - 2015-11-09 13:05:13,856 DEBUG : BROWSER_OUTPUT: Values: 337.5 337.7 340.0 341.1 344.2 14275.3 14740.1 17562.6 17928.3 19077.7 14342.9 14497.5 15553.6 15983.4 17977.5 5351.6 5460.4 5523.0 5531.8 5534.4 3829.7 4003.3 5250.7 5444.6 5449.9 5775.7 5896.3 5945.8 5957.9 5959.9 5750.2 5922.8 5968.3 5969.7 5984.4 5115.6 5162.0 5162.9 5163.3 5171.5 20600.4 20634.5 20982.9 21478.7 21539.9 1909.6 1958.9 1970.7 2020.9 2226.4 12939.5 13015.3 13074.4 13173.1 13285.9 1626.1 1630.2 1651.5 1686.0 1706.8 54000.2 54547.0 54801.7 54805.2 54896.0 9192.1 9362.9 9528.9 9587.8 9680.2 11613.5 11638.2 11639.8 11668.5 11727.2 7418.4 7695.8 7885.8 7970.0 8048.5 8148.1 8154.4 8161.4 8247.2 8282.5 5591.4 5676.7 5685.6 5700.5 5760.6 1526.5 1593.9 1615.9 1649.2 1650.7 941.5 948.6 981.0 985.2 1038.1 17653.0 18068.5 18253.7 18516.0 18725.1 824.7 923.1 951.2 958.4 970.5 9759.7 10054.7 10110.7 10123.7 10170.5 530793.0 536458.0 543279.0 553627.0 570309.3 65118.7 65501.0 66835.7 67380.3 68118.7 1119.6 1130.9 1172.5 1200.4 1213.4 15680.4 15933.5 16022.5 16151.4 16452.6 32359.2 32975.6 33220.2 33575.7 33625.8 45088.3 45270.2 45270.5 45277.3 46036.0 8984.2 9141.1 9147.5 9153.7 9171.9 17736.1 17812.4 18521.1 18653.3 18722.3 11787.1 13193.0 14075.6 14085.0 14488.6 13467.3 13559.3 13633.0 13837.3 14225.1 14120.2 14150.8 14349.4 14633.6 14735.3 8882.6 8904.6 8914.6 8959.6 9062.2 14135.2 14302.0 14650.0 14855.9 14988.3 13:05:13 INFO - 2015-11-09 13:05:13,856 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,857 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5481.28 Median:6509.01 stddev:2913.37 (44.8%) stddev-sans-first:2901.30 13:05:13 INFO - 2015-11-09 13:05:13,858 DEBUG : BROWSER_OUTPUT: Values: 912.9 1669.8 1760.0 1767.7 1799.0 7269.4 7511.7 8055.4 8168.4 8253.3 7939.8 8073.4 8090.5 8098.0 8184.8 1950.9 2033.9 2178.7 2196.9 2207.0 2221.7 2255.7 2262.2 2264.9 2273.3 2145.1 2181.2 2212.5 2215.6 2219.5 1899.5 1949.0 2146.9 2189.2 2198.7 2176.4 2206.7 2214.2 2226.5 2235.2 8108.7 8182.1 8186.7 8234.6 8262.2 4763.8 4797.8 4798.1 4811.5 4864.6 2893.7 3019.5 3034.5 3036.8 3071.7 940.9 944.9 977.2 989.7 1017.6 10435.2 10513.3 10531.6 10588.3 10637.6 4153.5 4230.4 4273.2 4291.0 4334.5 8708.2 8721.8 8725.2 8752.0 8767.5 4873.1 4873.7 4876.0 4889.5 4945.4 4524.0 4526.5 4527.6 4558.6 4563.1 3404.5 3484.7 3505.7 3520.5 3528.5 1028.5 1034.3 1035.5 1042.0 1043.7 1142.0 1257.4 1296.8 1307.7 1329.3 7646.1 7651.5 7667.4 7668.8 7709.3 461.7 463.0 469.3 469.5 470.4 5647.2 5736.8 5764.8 5768.9 5829.2 9340.4 9514.7 9579.9 9581.6 9647.3 9245.8 9439.6 9449.1 9491.3 9539.1 7278.7 7397.3 7420.7 7431.2 7516.1 7169.8 7234.7 7251.9 7266.4 7311.6 8397.3 8521.9 8522.7 8549.8 8560.0 8648.5 8738.4 8779.3 8805.1 8806.8 6654.4 6726.5 6742.0 6768.3 6803.6 7652.8 7713.0 7748.7 7767.2 7855.6 7204.2 7266.8 7300.6 7370.4 7441.0 6377.5 6640.5 7013.7 7027.0 7201.6 7210.6 7371.3 7408.6 7456.4 7470.5 5478.9 5491.1 5505.9 5517.7 5569.7 6877.1 6877.6 6894.1 6894.1 6937.0 13:05:13 INFO - 2015-11-09 13:05:13,858 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,858 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5353.83 Median:6078.21 stddev:1598.86 (26.3%) stddev-sans-first:1558.00 13:05:13 INFO - 2015-11-09 13:05:13,859 DEBUG : BROWSER_OUTPUT: Values: 316.9 322.7 326.0 330.1 333.6 6035.1 6090.5 6115.4 6157.0 6159.2 5942.7 5982.5 6025.9 6038.1 6042.9 4691.9 4743.3 4745.1 4761.5 4771.9 4616.9 4795.3 4809.3 4818.7 4827.8 4719.3 4721.8 4744.5 4775.0 4789.8 4546.3 4722.1 4769.2 4770.8 4792.4 3943.5 3993.0 4064.0 4064.1 4122.4 5709.2 5833.8 5877.2 5880.7 5898.3 5065.6 5079.2 5194.4 5222.4 5260.4 6209.8 6241.1 6313.3 6321.8 6323.3 4345.1 4358.4 4363.0 4408.5 4429.1 6393.1 6506.4 6532.6 6581.8 6644.0 4468.2 4478.3 4498.1 4505.8 4543.0 4542.7 4546.1 4559.0 4573.0 4589.2 5242.3 5242.9 5259.2 5322.3 5334.9 6233.3 6347.5 6349.7 6421.9 6429.1 1614.8 1626.4 1628.0 1628.6 1650.9 1067.2 1072.4 1075.4 1085.5 1090.9 6035.2 6058.4 6112.4 6122.0 6148.3 6589.9 6600.9 6650.1 6655.8 6682.8 5938.8 6057.0 6065.9 6123.4 6132.2 3614.9 3643.5 3654.5 3689.2 3707.5 6770.9 6800.0 6807.8 6834.9 6838.6 6494.9 6734.6 6777.4 6811.0 6839.0 6328.0 6700.0 6727.6 6776.1 6786.9 6537.7 6547.3 6598.2 6613.3 6615.9 6419.5 6453.5 6468.5 6472.9 6501.7 6531.2 6707.1 6778.8 6904.4 6940.0 4505.3 4523.2 4526.0 4560.2 4576.5 6641.5 6658.4 6733.4 6745.3 6749.4 6322.3 6359.5 6438.9 6468.5 6473.9 6361.8 6376.1 6444.9 6456.6 6478.3 6291.9 6302.9 6303.9 6308.5 6342.7 6284.2 6396.6 6402.7 6449.5 6458.6 6371.5 6384.9 6387.4 6414.7 6430.6 13:05:13 INFO - 2015-11-09 13:05:13,859 DEBUG : BROWSER_OUTPUT: 13:05:13 INFO - 2015-11-09 13:05:13,859 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13044.85 Median:49271.51 stddev:15061.82 (30.6%) stddev-sans-first:15075.78 13:05:13 INFO - 2015-11-09 13:05:13,861 DEBUG : BROWSER_OUTPUT: Values: 752.5 755.3 759.5 775.0 776.9 13704.2 14000.2 14003.9 14056.7 14155.3 12708.4 12747.8 12823.3 12867.0 12925.9 694.0 714.5 877.5 895.6 898.2 855.8 870.7 871.7 874.6 878.0 724.7 735.4 936.5 938.6 946.0 918.8 923.4 924.2 931.4 933.5 690.2 691.3 697.9 698.2 698.4 13451.7 13590.5 13635.5 13718.3 13780.4 11510.4 11926.0 11930.2 12014.0 12117.6 9269.4 9291.7 9386.5 9498.9 9886.9 3241.7 3336.4 3374.3 3393.7 3411.0 46125.1 46585.1 46613.3 46707.8 46899.3 8720.2 9003.3 9030.2 9122.9 9667.5 19246.9 19371.0 19419.0 19429.0 19557.4 7037.4 7044.0 7112.1 7179.2 7282.5 3764.3 3768.5 3816.7 3850.0 3883.9 2969.4 2978.6 2984.8 2987.4 3022.0 418.9 422.7 424.5 428.4 430.6 536.2 578.9 584.3 602.0 614.8 7532.9 7918.6 7976.8 8000.2 8119.1 511.1 578.0 596.4 600.5 658.7 3571.8 3602.9 3933.8 3997.9 3998.1 49110.3 49801.3 49969.8 50080.7 50225.2 47913.8 48566.3 49432.8 49495.5 49547.8 43580.3 43682.6 43808.8 45621.5 45708.0 8238.7 8346.4 8346.5 8406.7 8572.6 34288.0 34565.5 34930.5 35176.3 35216.0 41343.2 41403.0 43658.1 44375.1 44910.1 7446.9 7586.1 7605.8 7678.9 7794.4 10800.0 11025.2 11037.3 11233.4 11618.8 10073.2 10134.6 10187.5 10688.6 10908.9 10355.0 10566.6 10716.4 10764.3 11147.8 9555.5 9710.9 10478.6 10587.6 10648.2 8122.7 8743.7 8823.8 9001.8 9111.6 7996.0 8480.9 8884.9 8893.7 9129.4 13:05:13 INFO - 2015-11-09 13:05:13,861 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:05:13 INFO - 2015-11-09 13:05:13,861 DEBUG : BROWSER_OUTPUT: 13:05:14 INFO - 2015-11-09 13:05:14,507 INFO : Browser exited with error code: 0 13:05:14 INFO - 2015-11-09 13:05:14,534 INFO : Completed test dromaeo_css (00:18:35) 13:05:14 INFO - 2015-11-09 13:05:14,535 INFO : Starting test kraken 13:05:14 INFO - 2015-11-09 13:05:14,535 DEBUG : operating with platform_type : mac_ 13:05:14 INFO - 2015-11-09 13:05:14,535 INFO : Initialising browser for kraken test... 13:05:14 INFO - 2015-11-09 13:05:14,548 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpfYqaNa/profile http://localhost:54245/getInfo.html 13:05:16 INFO - 2015-11-09 13:05:16,888 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:05:16 INFO - 2015-11-09 13:05:16,889 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:05:16 INFO - 2015-11-09 13:05:16,889 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:05:16 INFO - 2015-11-09 13:05:16,889 DEBUG : BROWSER_OUTPUT: __metrics 13:05:16 INFO - 2015-11-09 13:05:16,906 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:17 INFO - 2015-11-09 13:05:17,544 INFO : Browser initialized. 13:05:17 INFO - 2015-11-09 13:05:17,544 INFO : Running cycle 1/1 for kraken test... 13:05:17 INFO - 2015-11-09 13:05:17,544 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpfYqaNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:05:29 INFO - 2015-11-09 13:05:29,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 228442112 13:05:29 INFO - 2015-11-09 13:05:29,614 DEBUG : BROWSER_OUTPUT: 13:05:32 INFO - 2015-11-09 13:05:32,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54245/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:32 INFO - 2015-11-09 13:05:32,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 285437952 13:05:32 INFO - 2015-11-09 13:05:32,722 DEBUG : BROWSER_OUTPUT: 13:05:35 INFO - 2015-11-09 13:05:35,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54245/tests/kraken/driver.html?testName=audio-dft) 13:05:35 INFO - 2015-11-09 13:05:35,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 297086976 13:05:35 INFO - 2015-11-09 13:05:35,965 DEBUG : BROWSER_OUTPUT: 13:05:38 INFO - 2015-11-09 13:05:38,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54245/tests/kraken/driver.html?testName=audio-fft) 13:05:39 INFO - 2015-11-09 13:05:39,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 280932352 13:05:39 INFO - 2015-11-09 13:05:39,504 DEBUG : BROWSER_OUTPUT: 13:05:41 INFO - 2015-11-09 13:05:41,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54245/tests/kraken/driver.html?testName=audio-oscillator) 13:05:42 INFO - 2015-11-09 13:05:42,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 281931776 13:05:42 INFO - 2015-11-09 13:05:42,082 DEBUG : BROWSER_OUTPUT: 13:05:44 INFO - 2015-11-09 13:05:44,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:44 INFO - 2015-11-09 13:05:44,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 282537984 13:05:44 INFO - 2015-11-09 13:05:44,847 DEBUG : BROWSER_OUTPUT: 13:05:47 INFO - 2015-11-09 13:05:47,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54245/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:48 INFO - 2015-11-09 13:05:48,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 281649152 13:05:48 INFO - 2015-11-09 13:05:48,459 DEBUG : BROWSER_OUTPUT: 13:05:51 INFO - 2015-11-09 13:05:51,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54245/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:52 INFO - 2015-11-09 13:05:52,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 283619328 13:05:52 INFO - 2015-11-09 13:05:52,160 DEBUG : BROWSER_OUTPUT: 13:05:55 INFO - 2015-11-09 13:05:55,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54245/tests/kraken/driver.html?testName=json-parse-financial) 13:05:55 INFO - 2015-11-09 13:05:55,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 282398720 13:05:55 INFO - 2015-11-09 13:05:55,606 DEBUG : BROWSER_OUTPUT: 13:05:57 INFO - 2015-11-09 13:05:57,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:57 INFO - 2015-11-09 13:05:57,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 316461056 13:05:57 INFO - 2015-11-09 13:05:57,736 DEBUG : BROWSER_OUTPUT: 13:05:59 INFO - 2015-11-09 13:05:59,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:06:00 INFO - 2015-11-09 13:06:00,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 316747776 13:06:00 INFO - 2015-11-09 13:06:00,171 DEBUG : BROWSER_OUTPUT: 13:06:02 INFO - 2015-11-09 13:06:02,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:06:02 INFO - 2015-11-09 13:06:02,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 326426624 13:06:02 INFO - 2015-11-09 13:06:02,842 DEBUG : BROWSER_OUTPUT: 13:06:05 INFO - 2015-11-09 13:06:05,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:06:05 INFO - 2015-11-09 13:06:05,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 328101888 13:06:05 INFO - 2015-11-09 13:06:05,954 DEBUG : BROWSER_OUTPUT: 13:06:08 INFO - 2015-11-09 13:06:08,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:06:09 INFO - 2015-11-09 13:06:09,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 328306688 13:06:09 INFO - 2015-11-09 13:06:09,188 DEBUG : BROWSER_OUTPUT: 13:06:10 INFO - 2015-11-09 13:06:10,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54245/tests/kraken/driver.html?testName=ai-astar) 13:06:11 INFO - 2015-11-09 13:06:11,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 387149824 13:06:11 INFO - 2015-11-09 13:06:11,193 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,193 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:06:11 INFO - 2015-11-09 13:06:11,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:06:11 INFO - 2015-11-09 13:06:11,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:06:11 INFO - 2015-11-09 13:06:11,193 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;107;102;107;108;108;107;106;99;106 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;133;152;163;126;149;147;124;177;125 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;163;163;163;163;164;161;161 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;82;87;84;69;70;69;77;83;65 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;98;136;88;89;89;129;88;88;133 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;115;114;114;121;114;120;121;114;114 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;124;125;124;124;125;124;125;126 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;101;100;101;100;100;101;100;99;100 13:06:11 INFO - 2015-11-09 13:06:11,194 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;57;57;57;56;57;66;55;56 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;66;66;66;68;68;68;68;68 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;84;84;85;85;86;85;84;87;86 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;124;122;121;125;124;121;132;133;123 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;156;155;154;158;143;158;155;154;145 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;73;72;73;72;72;72;73;73;73 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929 13:06:11 INFO - 2015-11-09 13:06:11,195 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: __startTimestamp1447103171186__endTimestamp 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.60 Median:107.00 stddev:2.88 (2.7%) stddev-sans-first:3.05 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: Values: 106.0 107.0 102.0 107.0 108.0 108.0 107.0 106.0 99.0 106.0 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,196 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.50 stddev:17.97 (11.9%) stddev-sans-first:18.55 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: Values: 157.0 133.0 152.0 163.0 126.0 149.0 147.0 124.0 177.0 125.0 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 163.0 163.0 163.0 163.0 164.0 161.0 161.0 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.00 Median:79.50 stddev:7.67 (9.7%) stddev-sans-first:8.11 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: Values: 74.0 82.0 87.0 84.0 69.0 70.0 69.0 77.0 83.0 65.0 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,197 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:88.50 stddev:20.46 (23.1%) stddev-sans-first:21.63 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: Values: 99.0 98.0 136.0 88.0 89.0 89.0 129.0 88.0 88.0 133.0 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.50 stddev:3.30 (2.8%) stddev-sans-first:3.28 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 114.0 114.0 121.0 114.0 120.0 121.0 114.0 114.0 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.70 Median:125.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 124.0 125.0 124.0 124.0 125.0 124.0 125.0 126.0 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.20 Median:100.50 stddev:0.63 (0.6%) stddev-sans-first:0.67 13:06:11 INFO - 2015-11-09 13:06:11,198 DEBUG : BROWSER_OUTPUT: Values: 100.0 101.0 100.0 101.0 100.0 100.0 101.0 100.0 99.0 100.0 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.06 (5.4%) stddev-sans-first:3.24 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 57.0 57.0 57.0 56.0 57.0 66.0 55.0 56.0 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 66.0 66.0 68.0 68.0 68.0 68.0 68.0 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,199 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:1.03 (1.2%) stddev-sans-first:1.05 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 84.0 85.0 85.0 86.0 85.0 84.0 87.0 86.0 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:124.00 stddev:4.23 (3.4%) stddev-sans-first:4.47 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 122.0 121.0 125.0 124.0 121.0 132.0 133.0 123.0 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:155.50 stddev:5.17 (3.3%) stddev-sans-first:5.40 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: Values: 156.0 156.0 155.0 154.0 158.0 143.0 158.0 155.0 154.0 145.0 13:06:11 INFO - 2015-11-09 13:06:11,200 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,201 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 13:06:11 INFO - 2015-11-09 13:06:11,201 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 73.0 72.0 72.0 72.0 73.0 73.0 73.0 13:06:11 INFO - 2015-11-09 13:06:11,201 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:06:11 INFO - 2015-11-09 13:06:11,201 DEBUG : BROWSER_OUTPUT: 13:06:11 INFO - 2015-11-09 13:06:11,837 INFO : Browser exited with error code: 0 13:06:11 INFO - 2015-11-09 13:06:11,886 INFO : Completed test kraken (00:00:57) 13:06:11 INFO - 2015-11-09 13:06:11,886 INFO : Starting test v8_7 13:06:11 INFO - 2015-11-09 13:06:11,886 DEBUG : operating with platform_type : mac_ 13:06:11 INFO - 2015-11-09 13:06:11,886 INFO : Initialising browser for v8_7 test... 13:06:11 INFO - 2015-11-09 13:06:11,899 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmp0dC72C/profile http://localhost:54245/getInfo.html 13:06:14 INFO - 2015-11-09 13:06:14,192 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:06:14 INFO - 2015-11-09 13:06:14,192 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:06:14 INFO - 2015-11-09 13:06:14,192 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:06:14 INFO - 2015-11-09 13:06:14,192 DEBUG : BROWSER_OUTPUT: __metrics 13:06:14 INFO - 2015-11-09 13:06:14,208 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:06:14 INFO - 2015-11-09 13:06:14,859 INFO : Browser initialized. 13:06:14 INFO - 2015-11-09 13:06:14,860 INFO : Running cycle 1/1 for v8_7 test... 13:06:14 INFO - 2015-11-09 13:06:14,860 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmp0dC72C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:06:26 INFO - 2015-11-09 13:06:26,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 231743488 13:06:26 INFO - 2015-11-09 13:06:26,869 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54245/tests/v8_7/run.html (next: http://localhost:54245/tests/v8_7/run.html) 13:06:48 INFO - 2015-11-09 13:06:48,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 316874752 13:06:48 INFO - 2015-11-09 13:06:48,650 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,650 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:06:48 INFO - 2015-11-09 13:06:48,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:06:48 INFO - 2015-11-09 13:06:48,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |0;Richards;168.32183134152498 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.42914979757086 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.2642740619902 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5797.687861271676 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1908.3969465648854 13:06:48 INFO - 2015-11-09 13:06:48,651 DEBUG : BROWSER_OUTPUT: |5;Earley;937.207122774133 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: |6;Boyer;13064.935064935065 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: |7;RegExp;29171.428571428572 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: |8;Splay;690.1311249137336 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1447103208648__endTimestamp 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:06:48 INFO - 2015-11-09 13:06:48,652 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.32 Median:168.32 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: Values: 168.3 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.43 Median:202.43 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: Values: 202.4 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.26 Median:326.26 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,653 DEBUG : BROWSER_OUTPUT: Values: 326.3 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: Values: 5797.7 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1908.40 Median:1908.40 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: Values: 1908.4 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,654 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:937.21 Median:937.21 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: Values: 937.2 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13064.94 Median:13064.94 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: Values: 13064.9 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29171.43 Median:29171.43 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: Values: 29171.4 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,655 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:690.13 Median:690.13 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,656 DEBUG : BROWSER_OUTPUT: Values: 690.1 13:06:48 INFO - 2015-11-09 13:06:48,656 DEBUG : BROWSER_OUTPUT: 13:06:48 INFO - 2015-11-09 13:06:48,656 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 13:06:48 INFO - 2015-11-09 13:06:48,656 DEBUG : BROWSER_OUTPUT: Values: 5797.7 13:06:48 INFO - 2015-11-09 13:06:48,656 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:06:48 INFO - 2015-11-09 13:06:48,656 DEBUG : BROWSER_OUTPUT: 13:06:49 INFO - 2015-11-09 13:06:49,299 INFO : Browser exited with error code: 0 13:06:49 INFO - 2015-11-09 13:06:49,318 INFO : Completed test v8_7 (00:00:37) 13:06:49 INFO - 2015-11-09 13:06:49,661 INFO : Completed test suite (00:20:10) 13:06:49 INFO - 2015-11-09 13:06:49,661 DEBUG : Working with test: dromaeo_css 13:06:49 INFO - 2015-11-09 13:06:49,661 DEBUG : Generating results file: dromaeo_css 13:06:49 INFO - 2015-11-09 13:06:49,662 DEBUG : Working with test: kraken 13:06:49 INFO - 2015-11-09 13:06:49,662 DEBUG : Generating results file: kraken 13:06:49 INFO - 2015-11-09 13:06:49,662 INFO : javascript benchmark 13:06:49 INFO - 2015-11-09 13:06:49,662 DEBUG : Working with test: v8_7 13:06:49 INFO - 2015-11-09 13:06:49,662 DEBUG : Generating results file: v8_7 13:06:49 INFO - 2015-11-09 13:06:49,662 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:06:49 INFO - 2015-11-09 13:06:49,728 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 13:06:49 INFO - 2015-11-09 13:06:49,728 DEBUG : process_Request line: dromaeo_css 6936.00 graph.html#tests=[[72,64,55]] 13:06:49 INFO - 2015-11-09 13:06:49,728 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:06:49 INFO - 2015-11-09 13:06:49,758 DEBUG : process_Request line: kraken 1494.90 graph.html#tests=[[232,64,55]] 13:06:49 INFO - 2015-11-09 13:06:49,758 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:06:49 INFO - 2015-11-09 13:06:49,791 DEBUG : process_Request line: v8_7 17991.73 graph.html#tests=[[230,64,55]] 13:06:49 INFO - 2015-11-09 13:06:49,792 INFO : javascript benchmark 13:06:49 INFO - 2015-11-09 13:06:49,794 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [337.50218427818953, 337.72306708499025, 339.9796012239266, 341.0943943829134, 344.24610103872527, 14275.2862356882, 14740.115593064396, 17562.64874702507, 17928.28286868525, 19077.71383429248, 14342.856571434282, 14497.49258775943, 15553.611159721013, 15983.360665573364, 17977.460676179704, 5351.598630102748, 5460.372057213432, 5522.972385138089, 5531.834044978637, 5534.363548191969, 3829.6936245100464, 4003.339448990913, 5250.6587071840395, 5444.591655625824, 5449.863753406157, 5775.682337471438, 5896.321922978848, 5945.791897283596, 5957.85105372367, 5959.851003724898, 5750.1949727038245, 5922.822315330547, 5968.283805943314, 5969.731362088738, 5984.371640977722, 5115.641905066647, 5162.0, 5162.870928226786, 5163.277141200235, 5171.50870667286, 20600.38198854037, 20634.48413789652, 20982.895085524626, 21478.677819832716, 21539.8923005384, 1909.6180763847285, 1958.9314373996842, 1970.6945423459388, 2020.8888511131881, 2226.365485836529, 12939.48242070316, 13015.284159371231, 13074.411651475706, 13173.077884548085, 13285.933570332087, 1626.0731383111631, 1630.184907546227, 1651.5474520337289, 1685.9831401686072, 1706.8122506524273, 54000.189997150075, 54546.9999999996, 54801.725991370186, 54805.1779223312, 54896.0, 9192.126747959066, 9362.859557106649, 9528.857067143997, 9587.760305992406, 9680.177184939359, 11613.535458581562, 11638.243514171721, 11639.76720465586, 11668.474918628683, 11727.179097463095, 7418.443616728767, 7695.846083078307, 7885.802854928673, 7970.043594768665, 8048.5170889746805, 8148.144444833207, 8154.3884208684585, 8161.387895907831, 8247.175282471704, 8282.503049816909, 5591.356993945748, 5676.7161641918565, 5685.6304340218585, 5700.543956483471, 5760.607449628353, 1526.4809964612086, 1593.9043657380594, 1615.878809089323, 1649.150687395992, 1650.6698660267755, 941.5339406993583, 948.6158105966956, 980.9901900980899, 985.2265971212564, 1038.1383451735041, 17653.0, 18068.457946261635, 18253.726194107097, 18516.0, 18725.109555432125, 824.7135859142985, 923.0907556057278, 951.2390087929629, 958.3866325551653, 970.46624356605, 9759.658411955548, 10054.748631284276, 10110.69667909964, 10123.7469063274, 10170.491475426199, 530793.0, 536458.0, 543279.0, 553627.0, 570309.3360798775, 65118.674406627666, 65501.0, 66835.66582167058, 67380.34194441518, 68118.65940670265, 1119.6081371519904, 1130.9151813613848, 1172.5251273234353, 1200.3578085724096, 1213.3751118174148, 15680.372785088925, 15933.521994340188, 16022.519324420286, 16151.434699785452, 16452.588685282484, 32359.191020224684, 32975.576607906856, 33220.1694957628, 33575.66424335823, 33625.83187084049, 45088.323675145555, 45270.18919243325, 45270.54729452663, 45277.320840188084, 46036.0, 8984.23633991118, 9141.085891411072, 9147.496887670975, 9153.725388238363, 9171.862422063808, 17736.11319434049, 17812.376566820098, 18521.07394630236, 18653.347132850286, 18722.25110995545, 11787.11596630239, 13193.0, 14075.648108797363, 14085.0, 14488.637784055483, 13467.259300738553, 13559.254241016444, 13633.0, 13837.30813459303, 14225.14649121056, 14120.223387713775, 14150.78773818373, 14349.426022958965, 14633.634159146106, 14735.26323683833, 8882.60028298741, 8904.55477226149, 8914.598843052208, 8959.596818143069, 9062.229710474683, 14135.15189088658, 14302.0, 14650.047746896418, 14855.92572037133, 14988.325525351167], "dojo.html": [3130.2174456385906, 3201.119692084678, 3234.029791062682, 3237.465818140007, 3255.7232635225996, 5211.947880521194, 5323.467653234675, 5350.0904846176145, 5406.351237851459, 5476.945230547693, 5311.309529761135, 5341.1187154119525, 5348.090824559825, 5360.892782144355, 5475.6440831345935, 4985.501449855004, 5020.272060551218, 5029.874253143683, 5038.370203724535, 5080.110980578403, 5155.968806238749, 5177.275181474596, 5191.792328306882, 5210.2445145453885, 5239.161734122541, 4875.171220892421, 4955.281484184773, 4991.675541089818, 5002.699838009731, 5127.487251274899, 5021.246812978046, 5038.496150384969, 5053.267276244924, 5068.366454193226, 5074.949250507485, 5004.5495905368325, 5012.8997420051755, 5018.77415516299, 5026.949730502722, 5059.367579052619, 5137.6660517066275, 5230.607704422184, 5230.947690523122, 5260.710660913648, 5308.654937429054, 5689.146628005791, 5690.459406356389, 5709.543236541067, 5731.512821410185, 5768.307803063659, 5740.253767010304, 5752.36723960364, 5759.366469688331, 5764.481196692318, 5778.682172480512, 5161.66449180802, 5251.10731175701, 5251.501107394792, 5253.40295354441, 5407.972960135214, 5846.269216347957, 5857.4435428634215, 5872.588918775645, 5874.265716785402, 5894.646321220741, 5646.35066967304, 5655.1517272409465, 5659.603827732101, 5680.744366503517, 5710.571707121982, 5606.159076138611, 5632.464915832989, 5722.656640601577, 5733.082706766981, 5783.1325301204315, 5664.49019588239, 5678.488935995781, 5683.175939488834, 5691.345495268014, 5699.487046165865, 5672.205891175238, 5692.715364231772, 5711.286089238845, 5718.571107166979, 5726.656400615976, 4348.195583816941, 4463.330500424962, 4463.754493502888, 4468.664850136252, 4493.28107502798, 4012.6589239914933, 4043.6562892153906, 4060.3097473428998, 4106.548279689232, 4123.340265557496, 5259.0, 5295.179247216687, 5310.575153987672, 5312.5218730314455, 5349.251104845324, 5551.583631227674, 5719.456651618089, 5732.971335143381, 5748.13777933305, 5773.624714393551, 5201.45384734605, 5253.50091741284, 5282.154855223146, 5288.629795914326, 5314.335708036496, 5019.573336266385, 5061.9746901266, 5071.061853557104, 5071.340725705634, 5134.870328527718, 5687.289088863892, 5871.324797648325, 5874.471297583238, 5892.705364731832, 5939.792107276311, 5654.6324488908085, 5682.6306290091015, 5716.342620598684, 5761.711914404179, 5824.097264923944, 5898.262717160355, 5906.936751384792, 5914.053751399928, 5918.881622367615, 5929.61457505278, 5489.258950041693, 5712.0860662293835, 5716.485516303386, 5718.485336319751, 5723.198752174782, 5411.83764487066, 5429.864253393696, 5627.549796016391, 5657.519110875457, 5766.250387449605, 5490.670559766427, 5602.13166959122, 5623.578231632562, 5638.577106716931, 5694.772209111589, 5381.973090134525, 5596.776128954796, 5624.128260119688, 5626.071698169756, 5650.434956504317, 5409.810656626999, 5443.918341224806, 5475.452454754652, 5494.587905906993, 5540.445955404427, 5641.323041235078, 5665.886682266414, 5685.005124103182, 5685.77256909719, 5697.886042279214, 5181.740912954413, 5550.611457197957, 5553.972230138824, 5569.08110161835, 5575.7490912909825], "mootools.html": [912.9269658427327, 1669.8413650703183, 1759.9560010999724, 1767.7348397740338, 1799.019534353777, 7269.382102521286, 7511.661975211115, 8055.395845311603, 8168.4282100253, 8253.257206851382, 7939.801504962379, 8073.434859559833, 8090.514569125857, 8098.0, 8184.7953801155, 1950.8731932424419, 2033.8983050847473, 2178.749443813958, 2196.9450763730874, 2206.9889650551804, 2221.7444993825675, 2255.672927425522, 2262.1856131792624, 2264.920727774528, 2273.2839155665997, 2145.0776166248506, 2181.225664888965, 2212.4911270407815, 2215.645496720525, 2219.522802597441, 1899.477643647994, 1948.9512762180916, 2146.924857629991, 2189.1571744878256, 2198.681191227279, 2176.3579743975565, 2206.6800313954386, 2214.202886960693, 2226.4656482444257, 2235.1953296813135, 8108.702607582817, 8182.099969003405, 8186.672533098728, 8234.588270586506, 8262.215089566482, 4763.785629646674, 4797.784099715486, 4798.112349215371, 4811.542903424169, 4864.610831133501, 2893.681695013568, 3019.4866872631706, 3034.4841376965746, 3036.8481575921114, 3071.6774738652566, 940.8682784410188, 944.9102335278207, 977.1742877268697, 989.7278248481654, 1017.6031347774374, 10435.217358698128, 10513.264071514997, 10531.578736850517, 10588.258821882471, 10637.627683031134, 4153.54311025787, 4230.386593943923, 4273.18809426208, 4291.03451723366, 4334.544872788375, 8708.17272359125, 8721.825563488821, 8725.171108744658, 8752.037275899645, 8767.473951562926, 4873.122837889214, 4873.658843880965, 4875.95124048762, 4889.511048895082, 4945.381827271591, 4524.0, 4526.502084770673, 4527.61515271199, 4558.612517935946, 4563.06457176278, 3404.4893266010295, 3484.6689564491335, 3505.6669616386403, 3520.507129001942, 3528.4707293906117, 1028.454918892988, 1034.270839058462, 1035.4770840725537, 1041.9791604167874, 1043.7234132954773, 1141.9942900285446, 1257.4278703190027, 1296.8119622654851, 1307.6730817295677, 1329.335332333833, 7646.082470103512, 7651.464397492234, 7667.424943129287, 7668.769936901902, 7709.267619576131, 461.71373748276284, 463.00685030609156, 469.3499503188109, 469.47887844492584, 470.3556128104519, 5647.209390685307, 5736.799212027559, 5764.769409223668, 5768.913466297925, 5829.183914252008, 9340.439573625605, 9514.714558563253, 9579.856302155473, 9581.616735330648, 9647.324687271823, 9245.768855778659, 9439.622415103318, 9449.055094490495, 9491.288153388385, 9539.14147726708, 7278.745243916437, 7397.334239918326, 7420.740274090381, 7431.182569917305, 7516.060492438445, 7169.820754481179, 7234.74678386254, 7251.891221631574, 7266.38235749946, 7311.561306321638, 8397.328213743009, 8521.872171917303, 8522.659093636434, 8549.829003420022, 8560.0, 8648.481091134552, 8738.388312818042, 8779.297656187617, 8805.119488051143, 8806.823863522823, 6654.401103900672, 6726.461883049442, 6741.966290168518, 6768.255491895789, 6803.5712500375475, 7652.7704168875025, 7713.0, 7748.651310691145, 7767.184445633353, 7855.60721963888, 7204.171520275236, 7266.781996540112, 7300.634968251672, 7370.410367170506, 7440.962795185989, 6377.489800816016, 6640.535162538576, 7013.684384202825, 7026.9648651756415, 7201.567905925452, 7210.603416812126, 7371.262873712801, 7408.592527411044, 7456.366208872307, 7470.514416562906, 5478.91781623284, 5491.148871924858, 5505.862353441196, 5517.69652669107, 5569.66582005081, 6877.071595334566, 6877.552959057645, 6894.069300644549, 6894.103766510522, 6937.0], "ext.html": [552.2875490617101, 555.2725929032966, 570.1988705868255, 571.5884563114558, 576.5358886096691, 30639.846800765994, 31676.366472670532, 37894.62105378945, 38587.61412385875, 38646.613533864656, 40880.59119408805, 41000.38499422504, 41298.380524292086, 41398.17203655925, 41403.17193656125, 8192.016957965052, 8354.206350396702, 8845.513496757692, 9089.727308180765, 9096.54517274137, 10815.134789216883, 11229.7192570186, 11252.212345135844, 11257.493412796402, 11265.042471389941, 10888.836667449994, 10992.120630349593, 11039.116870650369, 11048.779024419508, 11103.500342484567, 8486.448380855225, 8632.007319158252, 10895.564177432932, 11008.0, 11340.092792576574, 10686.465676716132, 10989.395583242918, 10990.505427255714, 10991.725206869813, 11028.338299702044, 38718.80640596807, 39329.213415731814, 39346.0, 39409.80295098506, 39471.0, 2758.1036163246827, 2810.269329974201, 2897.797154199207, 3000.9849950750327, 3322.90031299059, 26126.738732612812, 26648.733512665014, 28036.85981570079, 28953.85523072371, 29408.41183176346, 2367.656689779972, 2408.7952524035477, 2435.683361163055, 2442.2673198040693, 2454.7667971542674, 266126.0, 267052.0, 268315.0, 268561.65719171474, 269070.999999998, 57341.42658573444, 58025.41974580284, 60788.0, 61277.0, 66570.66714666395, 60615.69692151511, 61539.692301538205, 61935.0, 61959.56485221802, 61988.0, 16553.66892662164, 16734.4142954996, 16748.832511674726, 16750.162491875602, 16755.2460139294, 12700.682482938, 12760.234385936874, 12763.744725105631, 12784.552540661032, 12789.424475898606, 19562.90218548898, 19952.0, 19983.800161998486, 20079.498012549804, 20109.19563217484, 8198.180181981754, 8420.326373890073, 8428.957855210685, 8440.746777596682, 8489.830203395897, 920.9033051529493, 945.7966537194399, 1037.8479887325063, 1050.495762034228, 1131.2477202660302, 27395.90416383362, 27667.861660691568, 28036.71963280382, 28167.859160704065, 28224.29439264035, 994.5524513968743, 1036.9377837329785, 1057.2176589323844, 1098.1653943003375, 1141.1156353825852, 14458.421663133568, 14621.529401231619, 14659.633509162357, 14810.407583696531, 14846.777298340534, 298194.0, 305775.0, 306001.0, 306334.0, 307145.0, 53407.46592534025, 53998.46001540013, 54005.45994540083, 54215.72892135514, 54237.0, 1323.894088472939, 1342.9731405372033, 1343.6439343573961, 1354.2010213973606, 1364.433759989613, 27446.725532744418, 28167.859160704884, 28180.43639127165, 31060.0, 31102.68897310998, 51743.0, 52151.47848521466, 52577.21134183067, 52654.47345526495, 52664.47335526596, 271332.0, 276441.0, 276606.0, 276733.0, 277305.0, 34557.481637775956, 35186.0, 41592.792036039624, 45331.773341133085, 45968.0, 42875.57124428716, 43073.7846310779, 43078.78460607677, 43193.0, 43724.56275437332, 35550.64449355473, 35801.82099089488, 36077.639223607424, 36404.27191456209, 36798.63201367952, 30836.832633472946, 35400.645993539736, 35712.0, 36303.755526502595, 39012.41481377725, 34318.48522272218, 35489.46765798567, 35990.82004590065, 36030.0, 36043.09892252715, 29523.704762952097, 31613.367732644758, 31724.524132137576, 31810.363792723554, 31823.363532728752, 23594.882025589763, 23697.881510592335, 23785.52428951446, 23813.52372952566, 23838.404039899142], "prototype.html": [316.92552250221195, 322.7031131359149, 325.9641439441661, 330.0724962854379, 333.6196735721278, 6035.094735789634, 6090.482309003734, 6115.388461153893, 6156.969215153924, 6159.23009623797, 5942.732577034033, 5982.521398288138, 6025.9096113558335, 6038.064100064497, 6042.939570604292, 4691.929621055679, 4743.335932969387, 4745.050989802036, 4761.50004249554, 4771.90456190876, 4616.907661846761, 4795.328653988445, 4809.326694262806, 4818.710877347353, 4827.806887724487, 4719.339292499053, 4721.811127554894, 4744.549267819569, 4774.952250477486, 4789.832355867546, 4546.272596384596, 4722.055588882237, 4769.165396055676, 4770.76146192689, 4792.376990991166, 3943.4676318696897, 3993.0416699992084, 4063.9796801015805, 4064.1465292288653, 4122.443470131524, 5709.229254050691, 5833.766649334021, 5877.23595932526, 5880.7353669085, 5898.292204935392, 5065.594752419835, 5079.187330027178, 5194.428612852583, 5222.4255331913455, 5260.395054568736, 6209.782657606962, 6241.126242326078, 6313.337099604567, 6321.778737744157, 6323.30443651198, 4345.109252603209, 4358.36803663467, 4362.978185109086, 4408.515063343029, 4429.092036132585, 6393.104965304861, 6506.446952009085, 6532.608043517404, 6581.835454113638, 6644.0, 4468.151051300242, 4478.305862591238, 4498.145352383102, 4505.81976720934, 4543.045960348298, 4542.659300552472, 4546.113507866001, 4559.019810740707, 4573.0396616710195, 4589.242774942164, 5242.344706911636, 5242.947570524246, 5259.158534634516, 5322.281491998608, 5334.946650533522, 6233.34549872266, 6347.460465860361, 6349.650769207646, 6421.903671444932, 6429.1320671709655, 1614.8385161483757, 1626.3738460692482, 1628.0150508942156, 1628.5928517870532, 1650.9422170223984, 1067.1836045425257, 1072.4316112460408, 1075.4300220882944, 1085.478970094359, 1090.86909570852, 6035.155078289043, 6058.363871793486, 6112.358202388774, 6122.0, 6148.262208535004, 6589.868202636017, 6600.86798264032, 6650.102236198148, 6655.767048153291, 6682.79951601443, 5938.8218353449465, 6057.000594901792, 6065.939340606626, 6123.38766123393, 6132.233470816148, 3614.855405783739, 3643.4899114124046, 3654.470101835219, 3689.1883785567134, 3707.480952666629, 6770.932290677129, 6800.0, 6807.795766127024, 6834.931650683529, 6838.589684618839, 6494.935050649433, 6734.629595372302, 6777.390034896883, 6811.046453496514, 6839.0425340452375, 6327.968360158262, 6700.0, 6727.596344219362, 6776.085228494188, 6786.864262714619, 6537.673116344259, 6547.345265473415, 6598.208215014229, 6613.305602911625, 6615.933840661532, 6419.518536109904, 6453.45145662624, 6468.5472016958365, 6472.8705425890275, 6501.707423165874, 6531.150950376421, 6707.094542236736, 6778.762743304158, 6904.4131248844415, 6939.965300173467, 4505.324201369821, 4523.163214805271, 4525.977370113128, 4560.2019646562385, 4576.496585375539, 6641.538861450473, 6658.3674550917585, 6733.360330768569, 6745.325467453215, 6749.3925546699065, 6322.336154703874, 6359.523035772429, 6438.90341644885, 6468.482521398371, 6473.8705225896165, 6361.840953976188, 6376.075469057054, 6444.871102578016, 6456.580322279036, 6478.255000674794, 6291.930371836707, 6302.873942521215, 6303.905441418474, 6308.463780578702, 6342.651154186564, 6284.245890492987, 6396.648184349905, 6402.679866006588, 6449.451796597342, 6458.61248325102, 6371.5221358397375, 6384.872302554016, 6387.361263873576, 6414.711337989708, 6430.582012169194], "yui.html": [752.4695089961574, 755.2598453515554, 759.5290919629826, 775.0157300228706, 776.9417293702974, 13704.177749335035, 14000.159990400583, 14003.929980350083, 14056.71886562268, 14155.292235388228, 12708.364581770898, 12747.808782868264, 12823.294718790463, 12867.0, 12925.935370323135, 693.972241110355, 714.5391222661381, 877.5217506458995, 895.6417433026809, 898.2095755734977, 855.8159995600945, 870.7344260000697, 871.7471933139382, 874.6020560644923, 877.9517126558037, 724.6847621284732, 735.4447392218867, 936.484933286693, 938.6151677812098, 946.0444950599909, 918.8208299381623, 923.3582660051267, 924.2328867040374, 931.4132096778986, 933.4912472702393, 690.2372877969822, 691.2603514239765, 697.8813601687725, 698.2040473859804, 698.3644883156354, 13451.66370840727, 13590.524331648443, 13635.454581816715, 13718.314084295846, 13780.379882905294, 11510.366929818856, 11926.0, 11930.164888457724, 12014.0, 12117.636470905887, 9269.397489163182, 9291.674791382336, 9386.530673466299, 9498.905010949871, 9886.851697224547, 3241.7406607471344, 3336.366090442808, 3374.3420033093557, 3393.6606339366112, 3410.9658903410896, 46125.07749845018, 46585.068298633836, 46613.30080048802, 46707.76646116748, 46899.29651055237, 8720.171583699539, 9003.279737620975, 9030.232430243372, 9122.86315705265, 9667.516624168764, 19246.90376548108, 19371.0, 19419.029048547516, 19429.0, 19557.43540516784, 7037.366637002592, 7044.049053377728, 7112.146542414944, 7179.210286868441, 7282.526635768658, 3764.3036038333, 3768.474006161699, 3816.656500914931, 3849.9807500962875, 3883.9029024274055, 2969.391274788706, 2978.5829983802287, 2984.805987610798, 2987.4323878463024, 3022.0, 418.8554948542748, 422.7463521886905, 424.5330136849503, 428.4194915888988, 430.6232046958911, 536.1716148550499, 578.9392113828071, 584.2959234122872, 601.9819405417844, 614.7694614519555, 7532.924670753222, 7918.564478953597, 7976.800579985431, 8000.199980002069, 8119.147489513634, 511.1463855361555, 577.9913301300484, 596.3708287756372, 600.5495878091432, 658.706875440434, 3571.8392672329805, 3602.8558857645926, 3933.8033098344968, 3997.900052498711, 3998.140399814054, 49110.26334604984, 49801.25298120531, 49969.75015124901, 50080.749596251786, 50225.24662130071, 47913.76043119762, 48566.27150592744, 49432.75283623559, 49495.50504494981, 49547.752261238464, 43580.346294805604, 43682.563174368486, 43808.78095609565, 45621.5437845624, 45708.0, 8238.711645092393, 8346.415750897379, 8346.457480263764, 8406.747797566082, 8572.614232359683, 34288.0, 34565.48151777776, 34930.47604285887, 35176.296474070885, 35216.0, 41343.173136537705, 41403.0, 43658.126837462434, 44375.11249774922, 44910.10179796451, 7446.925530744623, 7586.127595326388, 7605.771826845204, 7678.884816727642, 7794.415418843496, 10800.0, 11025.17311201647, 11037.282576632493, 11233.438328083399, 11618.825717614412, 10073.163710005787, 10134.6452874152, 10187.541560629641, 10688.625898093529, 10908.945455272673, 10355.0, 10566.577336906437, 10716.410597417216, 10764.300320479144, 11147.777044459228, 9555.474448905377, 9710.902890971, 10478.580856765644, 10587.576496940035, 10648.201384896009, 8122.7157049502985, 8743.737687869374, 8823.823523529622, 9001.819963600823, 9111.635534578543, 7996.0, 8480.872786908325, 8884.86672699923, 8893.73318800437, 9129.360944733804]}, "summary": {"lowerIsBetter": false, "suite": 6935.994762493893, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8876.740184672613, "unit": "ms", "value": 8876.740184672613}, "dojo.html": {"lowerIsBetter": false, "filtered": 5307.360692461046, "unit": "ms", "value": 5307.360692461046}, "mootools.html": {"lowerIsBetter": false, "filtered": 4377.405687880615, "unit": "ms", "value": 4377.405687880615}, "ext.html": {"lowerIsBetter": false, "filtered": 18750.692640207053, "unit": "ms", "value": 18750.692640207053}, "prototype.html": {"lowerIsBetter": false, "filtered": 4828.10089144897, "unit": "ms", "value": 4828.10089144897}, "yui.html": {"lowerIsBetter": false, "filtered": 5963.068048811473, "unit": "ms", "value": 5963.068048811473}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1447101999, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151109111239", "branch": "Fx-Team", "revision": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 162.0, 163.0, 163.0, 163.0, 163.0, 164.0, 161.0, 161.0], "ai-astar": [106.0, 107.0, 102.0, 107.0, 108.0, 108.0, 107.0, 106.0, 99.0, 106.0], "imaging-gaussian-blur": [120.0, 115.0, 114.0, 114.0, 121.0, 114.0, 120.0, 121.0, 114.0, 114.0], "audio-beat-detection": [157.0, 133.0, 152.0, 163.0, 126.0, 149.0, 147.0, 124.0, 177.0, 125.0], "json-stringify-tinderbox": [66.0, 65.0, 66.0, 66.0, 66.0, 68.0, 68.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [156.0, 156.0, 155.0, 154.0, 158.0, 143.0, 158.0, 155.0, 154.0, 145.0], "json-parse-financial": [57.0, 58.0, 57.0, 57.0, 57.0, 56.0, 57.0, 66.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [71.0, 73.0, 72.0, 73.0, 72.0, 72.0, 72.0, 73.0, 73.0, 73.0], "audio-fft": [74.0, 82.0, 87.0, 84.0, 69.0, 70.0, 69.0, 77.0, 83.0, 65.0], "imaging-darkroom": [125.0, 125.0, 124.0, 125.0, 124.0, 124.0, 125.0, 124.0, 125.0, 126.0], "stanford-crypto-ccm": [124.0, 124.0, 122.0, 121.0, 125.0, 124.0, 121.0, 132.0, 133.0, 123.0], "audio-oscillator": [99.0, 98.0, 136.0, 88.0, 89.0, 89.0, 129.0, 88.0, 88.0, 133.0], "stanford-crypto-aes": [86.0, 84.0, 84.0, 85.0, 85.0, 86.0, 85.0, 84.0, 87.0, 86.0], "imaging-desaturate": [100.0, 101.0, 100.0, 101.0, 100.0, 100.0, 101.0, 100.0, 99.0, 100.0]}, "summary": {"lowerIsBetter": true, "suite": 1494.9000000000005, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.0, "unit": "ms", "value": 76.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 153.4, "unit": "ms", "value": 153.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.9, "unit": "ms", "value": 124.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 124.7, "unit": "ms", "value": 124.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.6, "unit": "ms", "value": 57.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.7, "unit": "ms", "value": 103.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 105.6, "unit": "ms", "value": 105.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.3, "unit": "ms", "value": 162.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.4, "unit": "ms", "value": 72.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 116.7, "unit": "ms", "value": 116.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.2, "unit": "ms", "value": 85.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 100.2, "unit": "ms", "value": 100.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1447101999, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151109111239", "branch": "Fx-Team", "revision": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.42914979757086], "Encrypt": [326.2642740619902], "NavierStokes": [5797.687861271676], "Decrypt": [5797.687861271676], "Splay": [690.1311249137336], "Richards": [168.32183134152498], "RegExp": [29171.428571428572], "Earley": [937.207122774133], "Boyer": [13064.935064935065], "RayTrace": [1908.3969465648854]}, "summary": {"lowerIsBetter": false, "suite": 17991.725391558546, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 326.62292, "unit": "score", "value": 326.62292}, "Encrypt": {"lowerIsBetter": false, "filtered": 815.844765, "unit": "score", "value": 815.844765}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.96410767696923, "unit": "score", "value": 255.96410767696923}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.91157826520441, "unit": "score", "value": 45.91157826520441}, "Splay": {"lowerIsBetter": false, "filtered": 118.08045900000002, "unit": "score", "value": 118.08045900000002}, "RegExp": {"lowerIsBetter": false, "filtered": 31.228672869735533, "unit": "score", "value": 31.228672869735533}, "Richards": {"lowerIsBetter": false, "filtered": 209.72918199999998, "unit": "score", "value": 209.72918199999998}, "Earley": {"lowerIsBetter": false, "filtered": 711.116021, "unit": "score", "value": 711.116021}, "Boyer": {"lowerIsBetter": false, "filtered": 51.01158151093443, "unit": "score", "value": 51.01158151093443}, "RayTrace": {"lowerIsBetter": false, "filtered": 387.7542359999998, "unit": "score", "value": 387.7542359999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1447101999, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151109111239", "branch": "Fx-Team", "revision": "67fbffadaa47af2ba4d397f34f6c07e909bf0d6e"}}] 13:06:49 INFO - RETURN: dromaeo_css: 6936.00 13:06:49 INFO - RETURN: kraken: 1494.90 13:06:49 INFO - RETURN: v8_7: 17991.73 13:06:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "17991.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1494.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6936.00"}}} 13:06:49 INFO - Return code: 0 13:06:49 INFO - # TBPL SUCCESS # 13:06:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:06:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:06:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:06:49 INFO - 2015-11-09 13:06:49.895 screenresolution[1939:16940] starting screenresolution argv=screenresolution get 13:06:49 INFO - 2015-11-09 13:06:49.898 screenresolution[1939:16940] Display 0: 1600x1200x32@60 13:06:49 INFO - 2015-11-09 13:06:49.904 screenresolution[1940:16943] starting screenresolution argv=screenresolution list 13:06:49 INFO - Available Modes on Display 0 13:06:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:06:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:06:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:06:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:06:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:06:50 INFO - Intel HD Graphics 3000: 13:06:50 INFO - Chipset Model: Intel HD Graphics 3000 13:06:50 INFO - Type: GPU 13:06:50 INFO - Bus: Built-In 13:06:50 INFO - VRAM (Total): 512 MB 13:06:50 INFO - VRAM (Dynamic, Max): 10 13:06:50 INFO - Vendor: Intel (0x8086) 13:06:50 INFO - Device ID: 0x0116 13:06:50 INFO - Revision ID: 0x0009 13:06:50 INFO - Displays: 13:06:50 INFO - Display: 13:06:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:06:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:06:50 INFO - Display Serial Number: 1600x1200 60 13:06:50 INFO - Main Display: Yes 13:06:50 INFO - Mirror: Off 13:06:50 INFO - Online: Yes 13:06:50 INFO - Rotation: Supported 13:06:50 INFO - Return code: 0 13:06:50 INFO - Running post-action listener: _resource_record_post_action 13:06:50 INFO - Running post-run listener: _resource_record_post_run 13:06:51 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 4751360; Write bytes: 688777216; Read time: 1386; Write time: 56390 13:06:51 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 334219776; Write bytes: 334637056; Read time: 30540; Write time: 6909 13:06:51 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 4751360; Write bytes: 343781376; Read time: 1386; Write time: 48235 13:06:51 INFO - Running post-run listener: _upload_blobber_files 13:06:51 INFO - Blob upload gear active. 13:06:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:06:51 INFO - Copying logs to upload dir... 13:06:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.287540 ========= master_lag: 4.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-09 13:06:55.857355) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-09 13:06:55.861682) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010109 build_url: 'https://queue.taskcluster.net/v1/task/lERNM5c7TDmhCgAXwinJEA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.92 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-09 13:06:57.790468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 13:06:57.790802) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wma7AR9S45/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3UI7CujAcm/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005392 ========= master_lag: 0.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 13:06:58.167502) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2015-11-09 13:06:58.170835) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2015-11-09 13:07:01.074934) ========= ========= Total master_lag: 6.98 =========