builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0059 starttime: 1446494364.57 results: success (0) buildid: 20151102103507 builduid: 0198dd1d5ac34d668e1aed6dcb88fea2 revision: f8b520ee98535e9bfbe4a5dae90fc108e5628f6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.568539) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.568979) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.569315) ========= 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.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.006425 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.598228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.598533) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.614942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.615257) ========= 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.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.005835 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.666107) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.666422) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.666857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.667181) ========= 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.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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-02 11:59:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 965M=0s 2015-11-02 11:59:24 (965 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.889094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.889426) ========= 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.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.023155 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.945561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:24.945919) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f8b520ee98535e9bfbe4a5dae90fc108e5628f6e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f8b520ee98535e9bfbe4a5dae90fc108e5628f6e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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-02 11:59:25,033 truncating revision to first 12 chars 2015-11-02 11:59:25,033 Setting DEBUG logging. 2015-11-02 11:59:25,033 attempt 1/10 2015-11-02 11:59:25,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f8b520ee9853?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-02 11:59:25,298 unpacking tar archive at: mozilla-inbound-f8b520ee9853/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:25.521635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:25.521983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:25.539911) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:25.540205) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 11:59:25.540638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-02 11:59:25.540953) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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 11:59:25 INFO - MultiFileLogger online at 20151102 11:59:25 in /builds/slave/test 11:59:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:59:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:59:25 INFO - {'append_to_log': False, 11:59:25 INFO - 'base_work_dir': '/builds/slave/test', 11:59:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:59:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:59:25 INFO - 'branch': 'Mozilla-Inbound', 11:59:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:59:25 INFO - 'config_files': ('talos/mac_config.py',), 11:59:25 INFO - 'default_actions': ('clobber', 11:59:25 INFO - 'read-buildbot-config', 11:59:25 INFO - 'download-and-extract', 11:59:25 INFO - 'populate-webroot', 11:59:25 INFO - 'create-virtualenv', 11:59:25 INFO - 'install', 11:59:25 INFO - 'run-tests'), 11:59:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:59:25 INFO - 'download_minidump_stackwalk': True, 11:59:25 INFO - 'download_symbols': 'ondemand', 11:59:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:59:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:59:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:59:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:59:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:59:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:59:25 INFO - 'installer_path': 'installer.exe', 11:59:25 INFO - 'log_level': 'info', 11:59:25 INFO - 'log_name': 'talos', 11:59:25 INFO - 'log_to_console': True, 11:59:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:59:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:59:25 INFO - 'opt_config_files': (), 11:59:25 INFO - 'pip_index': False, 11:59:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:59:25 INFO - 'cmd': ('bash', 11:59:25 INFO - '-c', 11:59:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:59:25 INFO - 'enabled': True, 11:59:25 INFO - 'halt_on_failure': False, 11:59:25 INFO - 'name': 'check_screen_resolution'},), 11:59:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:59:25 INFO - 'cmd': ('bash', 11:59:25 INFO - '-c', 11:59:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:59:25 INFO - 'enabled': True, 11:59:25 INFO - 'halt_on_failure': False, 11:59:25 INFO - 'name': 'check_screen_resolution'},), 11:59:25 INFO - 'run_cmd_checks_enabled': True, 11:59:25 INFO - 'sps_profile': False, 11:59:25 INFO - 'sps_profile_interval': 0, 11:59:25 INFO - 'suite': 'dromaeojs', 11:59:25 INFO - 'system_bits': '64', 11:59:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:59:25 INFO - 'title': 't-yosemite-r5-0059', 11:59:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:59:25 INFO - 'use_talos_json': True, 11:59:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:59:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:59:25 INFO - 'work_dir': 'build'} 11:59:25 INFO - ##### 11:59:25 INFO - ##### Running clobber step. 11:59:25 INFO - ##### 11:59:25 INFO - Running pre-action listener: _resource_record_pre_action 11:59:25 INFO - Running main action method: clobber 11:59:25 INFO - rmtree: /builds/slave/test/build 11:59:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:59:28 INFO - Running post-action listener: _resource_record_post_action 11:59:28 INFO - ##### 11:59:28 INFO - ##### Running read-buildbot-config step. 11:59:28 INFO - ##### 11:59:28 INFO - Running pre-action listener: _resource_record_pre_action 11:59:28 INFO - Running main action method: read_buildbot_config 11:59:28 INFO - Using buildbot properties: 11:59:28 INFO - { 11:59:28 INFO - "properties": { 11:59:28 INFO - "buildnumber": 3239, 11:59:28 INFO - "product": "firefox", 11:59:28 INFO - "script_repo_revision": "production", 11:59:28 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 11:59:28 INFO - "repository": "", 11:59:28 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 11:59:28 INFO - "buildid": "20151102103507", 11:59:28 INFO - "slavename": "t-yosemite-r5-0059", 11:59:28 INFO - "pgo_build": "False", 11:59:28 INFO - "basedir": "/builds/slave/test", 11:59:28 INFO - "project": "", 11:59:28 INFO - "platform": "yosemite", 11:59:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:59:28 INFO - "slavebuilddir": "test", 11:59:28 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 11:59:28 INFO - "branch": "mozilla-inbound", 11:59:28 INFO - "repo_path": "integration/mozilla-inbound", 11:59:28 INFO - "stage_platform": "macosx64", 11:59:28 INFO - "builduid": "0198dd1d5ac34d668e1aed6dcb88fea2", 11:59:28 INFO - "revision": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e" 11:59:28 INFO - }, 11:59:28 INFO - "sourcestamp": { 11:59:28 INFO - "repository": "", 11:59:28 INFO - "hasPatch": false, 11:59:28 INFO - "project": "", 11:59:28 INFO - "branch": "mozilla-inbound-macosx64-talos", 11:59:28 INFO - "changes": [ 11:59:28 INFO - { 11:59:28 INFO - "category": null, 11:59:28 INFO - "files": [ 11:59:28 INFO - { 11:59:28 INFO - "url": null, 11:59:28 INFO - "name": "https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:59:28 INFO - } 11:59:28 INFO - ], 11:59:28 INFO - "repository": "", 11:59:28 INFO - "rev": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e", 11:59:28 INFO - "who": "wlachance@mozilla.com", 11:59:28 INFO - "when": 1446494327, 11:59:28 INFO - "number": 6610884, 11:59:28 INFO - "comments": "Bug 1149164 - Refine file size output for perfherder;r=gbrown", 11:59:28 INFO - "project": "", 11:59:28 INFO - "at": "Mon 02 Nov 2015 11:58:47", 11:59:28 INFO - "branch": "mozilla-inbound-macosx64-talos", 11:59:28 INFO - "revlink": "", 11:59:28 INFO - "properties": [ 11:59:28 INFO - [ 11:59:28 INFO - "buildid", 11:59:28 INFO - "20151102103507", 11:59:28 INFO - "Change" 11:59:28 INFO - ], 11:59:28 INFO - [ 11:59:28 INFO - "builduid", 11:59:28 INFO - "0198dd1d5ac34d668e1aed6dcb88fea2", 11:59:28 INFO - "Change" 11:59:28 INFO - ], 11:59:28 INFO - [ 11:59:28 INFO - "pgo_build", 11:59:28 INFO - "False", 11:59:28 INFO - "Change" 11:59:28 INFO - ] 11:59:28 INFO - ], 11:59:28 INFO - "revision": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e" 11:59:28 INFO - } 11:59:28 INFO - ], 11:59:28 INFO - "revision": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e" 11:59:28 INFO - } 11:59:28 INFO - } 11:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:59:28 INFO - Running post-action listener: _resource_record_post_action 11:59:28 INFO - ##### 11:59:28 INFO - ##### Running download-and-extract step. 11:59:28 INFO - ##### 11:59:28 INFO - Running pre-action listener: _resource_record_pre_action 11:59:28 INFO - Running main action method: download_and_extract 11:59:28 INFO - mkdir: /builds/slave/test/build/tests 11:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:28 INFO - https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/test_packages.json 11:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/test_packages.json 11:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:59:36 INFO - Downloaded 1149 bytes. 11:59:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:59:36 INFO - Using the following test package requirements: 11:59:36 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:59:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:59:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'jsshell-mac.zip'], 11:59:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:59:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:59:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:59:36 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:59:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:59:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:59:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:59:36 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:59:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:36 INFO - https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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 11:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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 11:59:44 INFO - Downloaded 17452417 bytes. 11:59:44 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 11:59:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:59:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:59:49 INFO - Return code: 0 11:59:49 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 11:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:49 INFO - https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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 11:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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 11:59:51 INFO - Downloaded 17452417 bytes. 11:59:51 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 11:59:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:59:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:59:57 INFO - Return code: 0 11:59: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')]} 11:59:57 INFO - https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:59:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:59:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:59:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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 11:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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 11:59:59 INFO - Downloaded 11131307 bytes. 11:59:59 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 11:59:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:59:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:00:00 INFO - Return code: 0 12:00: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:00:00 INFO - https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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:00:04 INFO - Downloaded 108547615 bytes. 12:00:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:04 INFO - mkdir: /builds/slave/test/properties 12:00:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:00:04 INFO - Writing to file /builds/slave/test/properties/build_url 12:00:04 INFO - Contents: 12:00:04 INFO - build_url:https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:04 INFO - Running post-action listener: _resource_record_post_action 12:00:04 INFO - Running post-action listener: set_extra_try_arguments 12:00:04 INFO - ##### 12:00:04 INFO - ##### Running populate-webroot step. 12:00:04 INFO - ##### 12:00:04 INFO - Running pre-action listener: _resource_record_pre_action 12:00:04 INFO - Running main action method: populate_webroot 12:00:04 INFO - Guessing talos json url... 12:00:04 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:00:04 INFO - https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 12:00:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:00:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 12:00:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/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:00:05 INFO - Downloaded 111 bytes. 12:00:05 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 12:00:05 INFO - Contents: 12:00:05 INFO - 20151102103507 12:00:05 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/f8b520ee98535e9bfbe4a5dae90fc108e5628f6e 12:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:05 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f8b520ee98/testing/talos/talos.json 12:00:05 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f8b520ee98/testing/talos/talos.json to /builds/slave/test/build/talos.json 12:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f8b520ee98/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 12:00:05 INFO - Downloaded 4264 bytes. 12:00:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:00:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:00:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:00:05 INFO - '../fennec_ids.txt'], 12:00:05 INFO - 'tests': ['tcheck2']}, 12:00:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:00:05 INFO - '--tppagecycles', 12:00:05 INFO - '7'], 12:00:05 INFO - 'tests': ['tsvgm']}}, 12:00:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:00:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:00:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:00:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:00:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'tests': ['damp', 'tps']}, 12:00:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['damp', 'tps']}, 12:00:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:00:05 INFO - 'other': {'tests': ['a11yr', 12:00:05 INFO - 'ts_paint', 12:00:05 INFO - 'tpaint', 12:00:05 INFO - 'sessionrestore', 12:00:05 INFO - 'sessionrestore_no_auto_restore']}, 12:00:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['a11yr', 12:00:05 INFO - 'ts_paint', 12:00:05 INFO - 'tpaint', 12:00:05 INFO - 'sessionrestore', 12:00:05 INFO - 'sessionrestore_no_auto_restore']}, 12:00:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['a11yr', 12:00:05 INFO - 'ts_paint', 12:00:05 INFO - 'tpaint', 12:00:05 INFO - 'sessionrestore', 12:00:05 INFO - 'sessionrestore_no_auto_restore']}, 12:00:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['a11yr', 12:00:05 INFO - 'ts_paint', 12:00:05 INFO - 'tpaint', 12:00:05 INFO - 'sessionrestore', 12:00:05 INFO - 'sessionrestore_no_auto_restore']}, 12:00:05 INFO - 'other_l64': {'tests': ['a11yr', 12:00:05 INFO - 'ts_paint', 12:00:05 INFO - 'tpaint', 12:00:05 INFO - 'sessionrestore', 12:00:05 INFO - 'sessionrestore_no_auto_restore']}, 12:00:05 INFO - 'other_nol64': {'tests': ['a11yr', 12:00:05 INFO - 'ts_paint', 12:00:05 INFO - 'tpaint', 12:00:05 INFO - 'sessionrestore', 12:00:05 INFO - 'sessionrestore_no_auto_restore']}, 12:00:05 INFO - 'svgr': {'tests': ['tsvgx', 12:00:05 INFO - 'tsvgr_opacity', 12:00:05 INFO - 'tart', 12:00:05 INFO - 'tscrollx', 12:00:05 INFO - 'cart']}, 12:00:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['tsvgx', 12:00:05 INFO - 'tsvgr_opacity', 12:00:05 INFO - 'tart', 12:00:05 INFO - 'tscrollx', 12:00:05 INFO - 'cart']}, 12:00:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'tests': ['tp5o']}, 12:00:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'talos_options': ['--e10s'], 12:00:05 INFO - 'tests': ['tp5o']}, 12:00:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'talos_options': ['--xperf_path', 12:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:05 INFO - 'tests': ['tp5n']}, 12:00:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:05 INFO - 'talos_options': ['--e10s', 12:00:05 INFO - '--xperf_path', 12:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:00:05 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:00:05 INFO - 'tests': ['tp5n']}}, 12:00:05 INFO - 'talos.zip': {'path': '', 12:00:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:00:05 INFO - Running post-action listener: _resource_record_post_action 12:00:05 INFO - ##### 12:00:05 INFO - ##### Running create-virtualenv step. 12:00:05 INFO - ##### 12:00:05 INFO - Running pre-action listener: _resource_record_pre_action 12:00:05 INFO - Running main action method: create_virtualenv 12:00:05 INFO - Creating virtualenv /builds/slave/test/build/venv 12:00:05 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:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:00:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:00:05 INFO - Using real prefix '/tools/python27' 12:00:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:00:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:00:11 INFO - Installing pip.................done. 12:00:11 INFO - Return code: 0 12:00:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:00:11 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:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:11 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:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:11 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:11 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:00:11 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:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:11 INFO - 'HOME': '/Users/cltbld', 12:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:11 INFO - 'LOGNAME': 'cltbld', 12:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:11 INFO - 'MOZ_NO_REMOTE': '1', 12:00:11 INFO - 'NO_EM_RESTART': '1', 12:00:11 INFO - 'PAGER': '/bin/cat', 12:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:11 INFO - 'PWD': '/builds/slave/test', 12:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:11 INFO - 'SHELL': '/bin/bash', 12:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:11 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:11 INFO - 'USER': 'cltbld', 12:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:11 INFO - 'XPC_FLAGS': '0x0', 12:00:11 INFO - 'XPC_SERVICE_NAME': '0', 12:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:11 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:00:11 INFO - Cleaning up... 12:00:11 INFO - Return code: 0 12:00:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:00:11 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:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:11 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:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:11 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:11 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:00:11 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:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:11 INFO - 'HOME': '/Users/cltbld', 12:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:11 INFO - 'LOGNAME': 'cltbld', 12:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:11 INFO - 'MOZ_NO_REMOTE': '1', 12:00:11 INFO - 'NO_EM_RESTART': '1', 12:00:11 INFO - 'PAGER': '/bin/cat', 12:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:11 INFO - 'PWD': '/builds/slave/test', 12:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:11 INFO - 'SHELL': '/bin/bash', 12:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:11 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:11 INFO - 'USER': 'cltbld', 12:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:11 INFO - 'XPC_FLAGS': '0x0', 12:00:11 INFO - 'XPC_SERVICE_NAME': '0', 12:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:12 INFO - Downloading/unpacking psutil>=0.7.1 12:00:12 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:00:12 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:00:12 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:00:12 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:00:12 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:00:12 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:00:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:00:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:15 INFO - Installing collected packages: psutil 12:00:15 INFO - Running setup.py install for psutil 12:00:15 INFO - building 'psutil._psutil_osx' extension 12:00:15 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:00:15 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:00:15 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:00:16 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:00:16 INFO - building 'psutil._psutil_posix' extension 12:00:16 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:00:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:00:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:00:16 INFO - ^ 12:00:16 INFO - 1 warning generated. 12:00:16 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:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:16 INFO - Successfully installed psutil 12:00:16 INFO - Cleaning up... 12:00:16 INFO - Return code: 0 12:00:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:16 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:16 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:00:16 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:00:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:16 INFO - 'HOME': '/Users/cltbld', 12:00:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:16 INFO - 'LOGNAME': 'cltbld', 12:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:16 INFO - 'MOZ_NO_REMOTE': '1', 12:00:16 INFO - 'NO_EM_RESTART': '1', 12:00:16 INFO - 'PAGER': '/bin/cat', 12:00:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:16 INFO - 'PWD': '/builds/slave/test', 12:00:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:16 INFO - 'SHELL': '/bin/bash', 12:00:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:16 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:16 INFO - 'USER': 'cltbld', 12:00:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:16 INFO - 'XPC_FLAGS': '0x0', 12:00:16 INFO - 'XPC_SERVICE_NAME': '0', 12:00:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:00:16 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:00:16 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:00:16 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:00:16 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:00:16 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:00:16 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:00:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:00:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:00:19 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:00:19 INFO - Installing collected packages: mozsystemmonitor 12:00:19 INFO - Running setup.py install for mozsystemmonitor 12:00:19 INFO - Successfully installed mozsystemmonitor 12:00:19 INFO - Cleaning up... 12:00:20 INFO - Return code: 0 12:00:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:20 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:20 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:00:20 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:00:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:20 INFO - 'HOME': '/Users/cltbld', 12:00:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:20 INFO - 'LOGNAME': 'cltbld', 12:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:20 INFO - 'MOZ_NO_REMOTE': '1', 12:00:20 INFO - 'NO_EM_RESTART': '1', 12:00:20 INFO - 'PAGER': '/bin/cat', 12:00:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:20 INFO - 'PWD': '/builds/slave/test', 12:00:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:20 INFO - 'SHELL': '/bin/bash', 12:00:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:20 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:20 INFO - 'USER': 'cltbld', 12:00:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:20 INFO - 'XPC_FLAGS': '0x0', 12:00:20 INFO - 'XPC_SERVICE_NAME': '0', 12:00:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:20 INFO - Downloading/unpacking blobuploader==1.2.4 12:00:20 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:00:20 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:00:20 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:00:20 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:00:20 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:00:20 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:00:23 INFO - Downloading blobuploader-1.2.4.tar.gz 12:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:00:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:00:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:24 INFO - Downloading docopt-0.6.1.tar.gz 12:00:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:00:24 INFO - Installing collected packages: blobuploader, requests, docopt 12:00:24 INFO - Running setup.py install for blobuploader 12:00:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:00:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:00:24 INFO - Running setup.py install for requests 12:00:25 INFO - Running setup.py install for docopt 12:00:25 INFO - Successfully installed blobuploader requests docopt 12:00:25 INFO - Cleaning up... 12:00:25 INFO - Return code: 0 12:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:25 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:25 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:00:25 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:00:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:25 INFO - 'HOME': '/Users/cltbld', 12:00:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:25 INFO - 'LOGNAME': 'cltbld', 12:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:25 INFO - 'MOZ_NO_REMOTE': '1', 12:00:25 INFO - 'NO_EM_RESTART': '1', 12:00:25 INFO - 'PAGER': '/bin/cat', 12:00:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:25 INFO - 'PWD': '/builds/slave/test', 12:00:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:25 INFO - 'SHELL': '/bin/bash', 12:00:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:25 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:25 INFO - 'USER': 'cltbld', 12:00:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:25 INFO - 'XPC_FLAGS': '0x0', 12:00:25 INFO - 'XPC_SERVICE_NAME': '0', 12:00:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:00:26 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-A1Hgpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:00:26 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-l_pM7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:00:26 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-mwCQwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:00:26 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-OiQYO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:00:26 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-TYw5v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:00:26 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-kyX1Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-T8E5g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-giSjBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-cuaJY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Zb_wBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-rP3OQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-b3cn1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:00:27 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-VIzIAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:00:28 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-wCuALq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:28 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-O_j7N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:00:28 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Z2T1Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:00:28 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-5Knirc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:00:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:00:28 INFO - Running setup.py install for manifestparser 12:00:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:00:28 INFO - Running setup.py install for mozcrash 12:00:28 INFO - Running setup.py install for mozdebug 12:00:29 INFO - Running setup.py install for mozdevice 12:00:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:00:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:00:29 INFO - Running setup.py install for mozfile 12:00:29 INFO - Running setup.py install for mozhttpd 12:00:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:00:29 INFO - Running setup.py install for mozinfo 12:00:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:00:29 INFO - Running setup.py install for mozInstall 12:00:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:00:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:00:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:00:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:00:30 INFO - Running setup.py install for mozleak 12:00:30 INFO - Running setup.py install for mozlog 12:00:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:00:30 INFO - Running setup.py install for moznetwork 12:00:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:00:30 INFO - Running setup.py install for mozprocess 12:00:31 INFO - Running setup.py install for mozprofile 12:00:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:00:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:00:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:00:31 INFO - Running setup.py install for mozrunner 12:00:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:00:31 INFO - Running setup.py install for mozscreenshot 12:00:31 INFO - Running setup.py install for moztest 12:00:31 INFO - Running setup.py install for mozversion 12:00:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:00:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:00:32 INFO - Cleaning up... 12:00:32 INFO - Return code: 0 12:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:32 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:32 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:00:32 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:00:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:32 INFO - 'HOME': '/Users/cltbld', 12:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:32 INFO - 'LOGNAME': 'cltbld', 12:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:32 INFO - 'MOZ_NO_REMOTE': '1', 12:00:32 INFO - 'NO_EM_RESTART': '1', 12:00:32 INFO - 'PAGER': '/bin/cat', 12:00:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:32 INFO - 'PWD': '/builds/slave/test', 12:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:32 INFO - 'SHELL': '/bin/bash', 12:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:32 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:32 INFO - 'USER': 'cltbld', 12:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:32 INFO - 'XPC_FLAGS': '0x0', 12:00:32 INFO - 'XPC_SERVICE_NAME': '0', 12:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:00:32 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-OuSpIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:00:32 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:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:00:32 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-4hKbut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:00:32 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:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:00:32 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Yb6AlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:00:32 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:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:00:32 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-zGc5dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-UaHZ7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Gy8rV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-nWuBdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-VhkoXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-7DyYPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-xSBzs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:00:33 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:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:00:33 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-G53ZmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:00:34 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:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:00:34 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-zXT5gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:00:34 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:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:00:34 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-NBXNQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:00:34 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:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:00:34 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-8fq2je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:00:34 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:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:34 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-AP37ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:00:34 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:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:00:34 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-gtIKcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:00:34 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:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:00:34 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-MqZvA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:37 INFO - Downloading blessings-1.5.1.tar.gz 12:00:37 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:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:00:37 INFO - Installing collected packages: blessings 12:00:37 INFO - Running setup.py install for blessings 12:00:38 INFO - Successfully installed blessings 12:00:38 INFO - Cleaning up... 12:00:38 INFO - Return code: 0 12:00:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:00:38 INFO - Reading from file tmpfile_stdout 12:00:38 INFO - Current package versions: 12:00:38 INFO - blessings == 1.5.1 12:00:38 INFO - blobuploader == 1.2.4 12:00:38 INFO - docopt == 0.6.1 12:00:38 INFO - manifestparser == 1.1 12:00:38 INFO - mozInstall == 1.12 12:00:38 INFO - mozcrash == 0.16 12:00:38 INFO - mozdebug == 0.1 12:00:38 INFO - mozdevice == 0.47 12:00:38 INFO - mozfile == 1.2 12:00:38 INFO - mozhttpd == 0.7 12:00:38 INFO - mozinfo == 0.9 12:00:38 INFO - mozleak == 0.1 12:00:38 INFO - mozlog == 3.0 12:00:38 INFO - moznetwork == 0.27 12:00:38 INFO - mozprocess == 0.22 12:00:38 INFO - mozprofile == 0.27 12:00:38 INFO - mozrunner == 6.11 12:00:38 INFO - mozscreenshot == 0.1 12:00:38 INFO - mozsystemmonitor == 0.0 12:00:38 INFO - moztest == 0.7 12:00:38 INFO - mozversion == 1.4 12:00:38 INFO - psutil == 3.1.1 12:00:38 INFO - requests == 1.2.3 12:00:38 INFO - wsgiref == 0.1.2 12:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:00:38 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:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:38 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:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:38 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 0x10b74ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f4ad5e1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, '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.pm06oPxE2n/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.N1JpPNCScz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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:00:38 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:00:38 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:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:38 INFO - 'HOME': '/Users/cltbld', 12:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:38 INFO - 'LOGNAME': 'cltbld', 12:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:38 INFO - 'MOZ_NO_REMOTE': '1', 12:00:38 INFO - 'NO_EM_RESTART': '1', 12:00:38 INFO - 'PAGER': '/bin/cat', 12:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:38 INFO - 'PWD': '/builds/slave/test', 12:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:38 INFO - 'SHELL': '/bin/bash', 12:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:00:38 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:38 INFO - 'USER': 'cltbld', 12:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:38 INFO - 'XPC_FLAGS': '0x0', 12:00:38 INFO - 'XPC_SERVICE_NAME': '0', 12:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 INFO - Cleaning up... 12:00:38 INFO - Return code: 0 12:00:38 INFO - Running post-action listener: _resource_record_post_action 12:00:38 INFO - Running post-action listener: _start_resource_monitoring 12:00:38 INFO - Starting resource monitoring. 12:00:38 INFO - ##### 12:00:38 INFO - ##### Running install step. 12:00:38 INFO - ##### 12:00:38 INFO - Running pre-action listener: _resource_record_pre_action 12:00:38 INFO - Running main action method: install 12:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:00:39 INFO - Reading from file tmpfile_stdout 12:00:39 INFO - Detecting whether we're running mozinstall >=1.0... 12:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:00:39 INFO - Reading from file tmpfile_stdout 12:00:39 INFO - Output received: 12:00:39 INFO - Usage: mozinstall [options] installer 12:00:39 INFO - Options: 12:00:39 INFO - -h, --help show this help message and exit 12:00:39 INFO - -d DEST, --destination=DEST 12:00:39 INFO - Directory to install application into. [default: 12:00:39 INFO - "/builds/slave/test"] 12:00:39 INFO - --app=APP Application being installed. [default: firefox] 12:00:39 INFO - mkdir: /builds/slave/test/build/application 12:00:39 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:00:39 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:01:22 INFO - Reading from file tmpfile_stdout 12:01:22 INFO - Output received: 12:01:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:01:22 INFO - Running post-action listener: _resource_record_post_action 12:01:22 INFO - ##### 12:01:22 INFO - ##### Running run-tests step. 12:01:22 INFO - ##### 12:01:22 INFO - Running pre-action listener: _resource_record_pre_action 12:01:22 INFO - Running main action method: run_tests 12:01:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:01:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:01:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:01:22 INFO - 2015-11-02 12:01:22.877 screenresolution[2555:19912] starting screenresolution argv=screenresolution get 12:01:22 INFO - 2015-11-02 12:01:22.880 screenresolution[2555:19912] Display 0: 1600x1200x32@60 12:01:22 INFO - 2015-11-02 12:01:22.888 screenresolution[2556:19914] starting screenresolution argv=screenresolution list 12:01:22 INFO - Available Modes on Display 0 12:01:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:01:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:01:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:01:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:01:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:01:23 INFO - Intel HD Graphics 3000: 12:01:23 INFO - Chipset Model: Intel HD Graphics 3000 12:01:23 INFO - Type: GPU 12:01:23 INFO - Bus: Built-In 12:01:23 INFO - VRAM (Total): 512 MB 12:01:23 INFO - VRAM (Dynamic, Max): 10 12:01:23 INFO - Vendor: Intel (0x8086) 12:01:23 INFO - Device ID: 0x0116 12:01:23 INFO - Revision ID: 0x0009 12:01:23 INFO - Displays: 12:01:23 INFO - Display: 12:01:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:01:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:01:23 INFO - Display Serial Number: 1600x1200 60 12:01:23 INFO - Main Display: Yes 12:01:23 INFO - Mirror: Off 12:01:23 INFO - Online: Yes 12:01:23 INFO - Rotation: Supported 12:01:23 INFO - Return code: 0 12:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:01:23 INFO - Python 2.7.3 12:01:23 INFO - Return code: 0 12:01:23 INFO - grabbing minidump binary from tooltool 12:01: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:01:23 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 0x10b7039f0>, '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 0x10b462cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6cd990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:01:23 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:01:23 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:01:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:23 INFO - Return code: 0 12:01:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:01:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:01:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:01:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:01:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0059', '--webServer', 'localhost'] in /builds/slave/test/build 12:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0059 --webServer localhost 12:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pm06oPxE2n/Render', 12:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:23 INFO - 'HOME': '/Users/cltbld', 12:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:23 INFO - 'LOGNAME': 'cltbld', 12:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:23 INFO - 'MOZ_NO_REMOTE': '1', 12:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:23 INFO - 'NO_EM_RESTART': '1', 12:01:23 INFO - 'PAGER': '/bin/cat', 12:01:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:23 INFO - 'PWD': '/builds/slave/test', 12:01:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:23 INFO - 'SHELL': '/bin/bash', 12:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1JpPNCScz/Listeners', 12:01:23 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 12:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:23 INFO - 'USER': 'cltbld', 12:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:23 INFO - 'XPC_FLAGS': '0x0', 12:01:23 INFO - 'XPC_SERVICE_NAME': '0', 12:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:01:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0059', '--webServer', 'localhost'] with output_timeout 3600 12:01:23 INFO - mozversion INFO | application_buildid: 20151102103507 12:01:23 INFO - mozversion INFO | application_changeset: f8b520ee98535e9bfbe4a5dae90fc108e5628f6e 12:01:23 INFO - mozversion INFO | application_display_name: Nightly 12:01:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:23 INFO - mozversion INFO | application_name: Firefox 12:01:23 INFO - mozversion INFO | application_remotingname: firefox 12:01:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:01:23 INFO - mozversion INFO | application_vendor: Mozilla 12:01:23 INFO - mozversion INFO | application_version: 45.0a1 12:01:23 INFO - mozversion INFO | platform_buildid: 20151102103507 12:01:23 INFO - mozversion INFO | platform_changeset: f8b520ee98535e9bfbe4a5dae90fc108e5628f6e 12:01:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:01:23 INFO - mozversion INFO | platform_version: 45.0a1 12:01:23 INFO - 2015-11-02 12:01:23,574 DEBUG : using testdate: 1446494483 12:01:23 INFO - 2015-11-02 12:01:23,574 DEBUG : actual date: 1446494483 12:01:23 INFO - 2015-11-02 12:01:23,585 INFO : starting webserver on 'localhost:51663' 12:01:23 INFO - 2015-11-02 12:01:23,586 INFO : Starting test suite t-yosemite-r5-0059 12:01:23 INFO - 2015-11-02 12:01:23,586 INFO : Starting test dromaeo_css 12:01:23 INFO - 2015-11-02 12:01:23,586 DEBUG : operating with platform_type : mac_ 12:01:23 INFO - 2015-11-02 12:01:23,587 INFO : Initialising browser for dromaeo_css test... 12:01:23 INFO - 2015-11-02 12:01:23,603 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpLvvhjN/profile http://localhost:51663/getInfo.html 12:01:26 INFO - 2015-11-02 12:01:26,299 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:01:26 INFO - 2015-11-02 12:01:26,299 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:01:26 INFO - 2015-11-02 12:01:26,299 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:01:26 INFO - 2015-11-02 12:01:26,299 DEBUG : BROWSER_OUTPUT: __metrics 12:01:26 INFO - 2015-11-02 12:01:26,316 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:01:27 INFO - 2015-11-02 12:01:27,162 INFO : Browser initialized. 12:01:27 INFO - 2015-11-02 12:01:27,162 INFO : Running cycle 1/1 for dromaeo_css test... 12:01:27 INFO - 2015-11-02 12:01:27,162 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpLvvhjN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:01:39 INFO - 2015-11-02 12:01:39,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 220913664 12:01:39 INFO - 2015-11-02 12:01:39,328 DEBUG : BROWSER_OUTPUT: 12:02:30 INFO - 2015-11-02 12:02:30,373 DEBUG : BROWSER_OUTPUT: 1446494550365 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:04:41 INFO - 2015-11-02 12:04:41,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51663/tests/dromaeo/cssquery-ext.html) 12:04:42 INFO - 2015-11-02 12:04:42,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 323223552 12:04:42 INFO - 2015-11-02 12:04:42,738 DEBUG : BROWSER_OUTPUT: 12:07:45 INFO - 2015-11-02 12:07:45,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/dromaeo/cssquery-ext.html (next: http://localhost:51663/tests/dromaeo/cssquery-jquery.html) 12:07:46 INFO - 2015-11-02 12:07:46,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 346505216 12:07:46 INFO - 2015-11-02 12:07:46,342 DEBUG : BROWSER_OUTPUT: 12:10:48 INFO - 2015-11-02 12:10:48,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51663/tests/dromaeo/cssquery-mootools.html) 12:10:49 INFO - 2015-11-02 12:10:49,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 329592832 12:10:49 INFO - 2015-11-02 12:10:49,177 DEBUG : BROWSER_OUTPUT: 12:13:51 INFO - 2015-11-02 12:13:51,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51663/tests/dromaeo/cssquery-prototype.html) 12:13:51 INFO - 2015-11-02 12:13:51,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 308604928 12:13:51 INFO - 2015-11-02 12:13:51,964 DEBUG : BROWSER_OUTPUT: 12:16:55 INFO - 2015-11-02 12:16:55,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51663/tests/dromaeo/cssquery-yui.html) 12:16:55 INFO - 2015-11-02 12:16:55,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 309829632 12:16:55 INFO - 2015-11-02 12:16:55,788 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/dromaeo/cssquery-yui.html (next: http://localhost:51663/tests/dromaeo/cssquery-dojo.html) 12:19:58 INFO - 2015-11-02 12:19:58,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 356315136 12:19:58 INFO - 2015-11-02 12:19:58,894 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,895 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:19:58 INFO - 2015-11-02 12:19:58,895 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:19:58 INFO - 2015-11-02 12:19:58,895 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:19:58 INFO - 2015-11-02 12:19:58,895 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:19:58 INFO - 2015-11-02 12:19:58,897 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2538.5176816404883;2627.448235870467;2631.407933215026;2647.867606619669;2675.57190849464;4241.384999175118;4353.717008394452;4417.977910110449;4469.575390337916;4499.61753250974;4361.978190109045;4363.192809330276;4399.450068741407;4457.84397546086;4493.910121797562;4099.405586190001;4119.855805046824;4129.690273229505;4193.5387107418155;4211.68412369072;4175.686823488235;4196.412502249687;4226.4716910386205;4262.296721041024;4288.463942007249;4054.310767169559;4168.374743788426;4188.267053265667;4191.224623444673;4227.661787057028;4032.4556184914954;4101.794910254475;4112.609302116324;4114.650254728352;4119.526254480743;4135.545090040093;4153.460050193486;4168.416421700964;4173.7495750254775;4216.430781844473;4175.06061136245;4296.140771845643;4303.634191093761;4364.825406983717;4399.5160532341415;4513.390692256569;4559.954400456019;4589;4598.8620341389815;4617.561331673485;4638.5593368629925;4644.303354496818;4692.389989301403;4713.481517033124;4813.03739252151;4199.706020578591;4283.164782867373;4402.449693788277;4411.823527058914;4430.468343798765;4638.675292729544;4755.215389460769;4794.568488836021;4835.588974937099;4903.4606193318705;4549.203889319356;4550.13547425988;4556.7721613919175;4599.632029437637;4673.439187297546;4553.54464553542;4559.316102584573;4660.97669511657;4670.673052886334;4731.645126615517;4533.093381323749;4567.497575266718;4584.129015487047;4644.628429725613;4648.83729069481;4611.515790841981;4690.319903614025;4710.481846996828;4735.981763920705;4776.164171270014;3463.6363181866045;3549.5563054618174;3601.333753255656;3614.2771445710964;3677.632236776301;3200.48792193248;3232.224266176148;3300.7854489458587;3332.4001679697403;3370.292238629866;4366.104948485553;4386.912261754747;4387.122575484916;4473.8657840264195;4510.030343476168;4524.049949510574;4681.29780532916;4737.170995075848;4750.714957102516;4824.204006338985;4261.424707664426;4347.3261644445165;4365.541618130114;4390.165868484977;4435.2016637005645;4107.240160570244;4118.073433477443;4130.607592278729;4207.095474473003;4259.659227261812;4564.201264778717;4731.905361892743;4762.3808904842845;4797.160496912957;4906.975465122651;4604.562566556172;4665.346851440733;4716.198246298069;4717.268823332389;4717.528247175255;4723.0081682846985;4746.525347465364;4792.0895029944195;4837.443693975238;4862.246351815475;4449.110177964485;4563.429571303587;4693.55411235932;4703.215189495789;4783.689060211075;4539.523350048197;4616.238320677051;4707.246840505502;4748.810047598057;4751;4547.090581883703;4581.725096494221;4664.883377915579;4672.696274742131;4694.812207511662;4470.597646211857;4563.498015218257;4597.678162528591;4597.7241365518175;4638.628909687284;4329.1341731653165;4470.932936006027;4517.616002639681;4522.095580883903;4530.660200484911;4576.977115114536;4588.587027167571;4648.953510464988;4687.507811679725;4695.671303008757;4348.2825333819565;4473.597376236155;4542.818287268472;4567.954320456885;4608.769561521977 12:19:58 INFO - 2015-11-02 12:19:58,900 DEBUG : BROWSER_OUTPUT: |1;ext.html;424.17286291731125;435.96294314983226;438.0975191106321;443.1779049862505;471.61327711276766;25906.481870362604;26561.20316390509;32177;32898;33173.17067073318;34185.65814341856;34386;34386.31227375451;34445;34912.82543587285;6686.297938716438;7492.96253518733;7662.1571627120975;7673.117591476996;7693.384529237675;6710.832229194285;6903.033575299462;8737.694180703676;8914.375993680445;8940.19538241558;8842.602082906253;8876.068012858621;8881.067487913773;8925.152110549487;9025.458472491671;6858.142732158481;6990.790276291719;8718.34612404069;8788.824223515494;8832.249258813008;6699.464042876558;8965.327600429928;9174.311926605531;9183.08169183083;9193.724188274362;32413.351732965446;32802.50796238035;32814.83592582046;32820.83589582061;33312.83343583291;2504.0484615846044;2513.9748602513923;2527.027094568586;2800.5519116941396;2960.6891276416095;21804.127834886585;21838.454038649;22287.888560557254;22426.55146897053;23082.65376019361;1900.7624046994126;1901.847852171823;1906.20892329683;1940.505171181354;1955.6382069317222;232353;233909;237150;237763;238159;40392.79803600963;41245.793771030956;41291.1741765163;47762;48132.5186748135;49545.50454495481;50052.749736251084;50409.24386134211;50415.74792126016;51078.23382649263;13508.121972071784;13654.590362289147;13689.383977721027;13932.303384830719;13948.16311021342;10334.431606261727;10526.473676316153;10583.84124238137;10692.732681683021;10709.892901071045;15229.847701523064;15382.230888455533;15464.14947177916;15517.5344739658;15671.059736415851;6951.89572156418;6972.2330543640155;7097.396721278646;7155.713771449084;7200.855982880313;700.9509334346546;715.5456285258898;776.9883451748228;824.9152364640479;828.8342331533718;23049.769502304764;23491.295261142193;23572.7642723574;23608.29175124749;23876.40308992289;779.7154038775806;836.7740710008385;856.3662889461878;903.9909600903907;990.6631745206664;11081.058110060736;11208.607698730506;11272.014875151424;11279.154063445274;11305.773884522263;251679;251749;256206;257821;257840;41962.79018604948;41998.96012478522;42002.369964450554;42248;42275;989.366805244644;1023.9744006400049;1026.3533973596586;1107.451811353369;1132.869719982196;17285.97726453204;21371.25200618033;22116.889415552818;22181.223657171922;22583.209587664354;40908.795456022526;41443.37834932539;41628.79185604174;41652.375214371204;42057.15885682208;221486;224249;229065;231167;232308;24789.62815557804;25254.621180682672;25351.492970140862;25581.872090639426;25672;32891;32989.83505082555;33014.17464563405;33048.834755826065;33359.666403336625;27320.726792731817;27428.862855685595;28031.299217519725;28144.71855281421;28264.85867570649;27494.312642184104;27512.449751005268;27649;27880.16359509218;28057;27754.722452775215;28284.71715282821;28486.85756571204;28879;28916.42167156603;23838.523229534967;24564.754352456246;24672.876635616707;24870.041586692085;25613.743862561136;19159.329423470113;19171;19289.710654340477;19371.709424358363;19762.802371976097 12:19:58 INFO - 2015-11-02 12:19:58,901 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.52543151211427;278.26815475299964;279.80833129306427;283.31720553466135;284.96580410350754;13717.382717777711;14343.497977570787;14470.059446136007;14507.927460362684;15051.849481505182;14179.858201417983;14863.405463781462;14875.479358222465;15110.168940708256;15203.391864325442;4339.1104823511105;4371.956280437194;4470.396496472983;4494.775261236941;4525.660575456837;4420.270655341865;4465.665075119363;4490.685652004345;4511.887202819923;4520.841770538032;3155.2269693924904;3242.9784617845303;3321.501774733797;4420.160169567788;4491.977540112295;4722.409698787652;4898.804047838083;4921.089598424285;4931.5068493150575;4972.627052971042;4135.29699951009;4260.595243451867;4261.957380426187;4263.275243208662;4277.657787377002;14010.92994535031;14529.128252304896;15006.774898376532;16538.917305413517;17734.733978990327;1656.850883420498;1690.2647348403361;1701.5916180116806;1706.3942300483398;1735.1757914990405;10985.670429887115;11082.556697732081;11149.832752508719;11371.147163962736;11393.259438136494;1324.6886981559326;1396.3995481942761;1405.6977749783846;1411.647088227943;1487.7470829958934;47981.280280795465;48301.275480867815;49056.26415603769;49594.2560861591;49617;7861.056673199253;7870.567118808521;7913.485623434458;8172.550509722022;8237.8352432951;9943.950280248553;9945.850812237823;9978.401295922267;9978.600855965826;9980.60077596888;6699.799006029827;6703.396694297537;6771.3905748482875;6777.254502004874;6830.521863469509;6923.2038315594355;6971.128608923885;6992.230854605989;7054.717811287491;7056.294370563005;4853.927191092136;4880.316755654211;4913.852584422401;4972.204447288416;4981.302617633534;1377.4008306386754;1402.193738600309;1406.6413064668648;1413.7101894111681;1434.63416828708;708.0335342257883;755.2975732568764;768.0898135709202;779.7037125892125;869.0700949983583;14919.552413427615;15432.537023889301;15531.689366212839;15580.442991939188;15631.687366252838;655.1842955520312;743.6765007221876;774.8527779721835;774.9070111586645;842.7556008757514;6976.337247961435;8467.703630373031;8831.161039701217;8905.777355566162;9040.909590904006;434151;435528.3732161625;436584;441628;442389;53259.46740532545;54916.72541637266;55802.72098639481;55995.72002139963;56591;827.8054657155564;850.9149085091441;874.1084094223856;881.8456770065213;887.6937456577341;13631.683916821357;13810.240436776074;14022.859771402156;14038.719225615634;14059;27475.86262068677;28273;28472.715272847006;28708.282292942007;28881.133565993056;37680.43479347757;38083;38243.617563825115;38646.2270754589;38646.806765965994;7486.7753967378885;7554;7717.57553334572;7763.92236077632;7792.220777922163;14625.268736562917;14800;14860.108393496424;15379.61550961235;15535.300911459237;11797.17419780607;12084.45619947087;12133.21134126279;12248.938755306166;12424.316662583644;11597.304161750322;11630.825537616773;12025.699357516132;12081.093917956365;12354.629361119181;12207.328596927255;12253.938730306292;12586.87413125857;12902.483900644245;13009.463154684745;7530;7569.1673915868105;7597.696092156473;7620.69517219305;7717.536947783151;11833.290002599872;12183.147179697691;12234.877651223374;12263.816042759187;12400.937995309965 12:19:58 INFO - 2015-11-02 12:19:58,905 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1208.1663652080058;1302.5050480817288;1401.2993503248376;1404.6542274401747;1467;5750.798722044729;6033.155358249843;6078.513718902488;6175.289841668209;6182.845428864281;6126.26484821822;6231.003039513679;6288.465480434169;6294.339094395092;6382.776602818903;1777.7422273770296;1800.6038671492252;1801.4055361730598;1806.8283513066237;1808.222464340333;1795.0306834309458;1808.9819101809012;1815.8910465372053;1821.9726704099382;1839.7332386803905;1737.0967097109497;1749.2041121289783;1752.3165965273554;1752.7020406530858;1753.2110550252373;1738.2351765223325;1750.5886116762615;1773.5300145461463;1782.7236778299384;1784.0722824131508;1778;1796.6137280484627;1807.8553715702844;1811.529002459357;1813.4106415415042;5602.13166959122;6213.937860621381;6248.125262463259;6255.687215639246;6274.874502509924;3569.6430356964356;3662.597114317423;3721.14413684854;3805;3857.8842634721004;2223.1996481266733;2274.226762900605;2289.404754763757;2304.68886700295;2330.778576035274;653.1769969838039;663.515633587479;672.6804767735287;1211.3095535544744;1259.2004077410818;8117.918820811776;8196.13940536241;8202.302804261644;8325.417220794547;8389.32885369169;3305.7851239669826;3310.3710295043866;3359.3449277391164;3363.6972672459597;3414.7097496712563;6793.898091528631;6805.897911531331;6829.692663830139;6831.760888368884;6880.65596720162;3788.9242215156096;3802.1065049713297;3804.4863943367845;3823.2926908522013;3842.423636454554;3515.367233897923;3517.648235176462;3523.066387407339;3539.752217344761;3559.2703495783303;2730.754232119119;2735.4392349568293;2758.917232483029;2774.556071028666;2784.470950519395;782.4014628808966;788.5662885413115;789.7788619186637;790.7430085222326;831.846108469935;1025.933314334566;1052.1898138433364;1063.5905176506947;1064.4571268652887;1097.9780404391868;6003.5797494174985;6010.188624535632;6014.278286605635;6021.126936594169;6022.277326720734;366.6571755408701;372.5213101165044;374.8425661222293;377.0629984488544;378.6270523534316;4756.619470442425;4801.447833499123;4818.855434336975;4822.662413631012;4885.438174609894;6891.4486841053595;7017.333353331425;7040.683169257396;7173.318534739192;7235.095613048369;7224.711011559584;7255.782326530212;7267.491275610657;7332.816679582947;7347.155077166088;5587.245721827501;5619.241402410704;5666.291713535808;5745.626534275259;5787.131930210502;5746.224259724883;5757.193992840922;5763.510101641407;5772.278465191851;5772.567057470623;6291.528135389955;6439.967800161156;6460.192475940507;6514.1531600891585;6518.674066296761;6490.993895946136;6648.5346025777735;6652.866942661217;6656.73373065072;6656.83357916056;5224.921626175535;5292.153255479105;5300.231466437422;5301.072312345401;5306.389765177054;6012;6052.092186172109;6072.696365181635;6076.817695469143;6128.203333566787;5499.2060341405;5640.943590564042;5676.801311954062;5739.05305624584;5740.68426236561;5484.067708489487;5558.388577256418;5640.5769567281795;5659.660420374791;5664.0654292043;5478;5754.9424505754405;5756.769729210785;5759;5842.795502157404;4997.375328083989;5225.843224703265;5228.058949389147;5233.031889100528;5292.100342941632;4982.6512144149565;5333.12003519415;5376.838694839161;5401.432849550898;5435.592330575144 12:19:58 INFO - 2015-11-02 12:19:58,906 DEBUG : BROWSER_OUTPUT: |4;prototype.html;252.89252067871155;263.0949533604401;263.8140111221589;265.43859736656975;265.53133718986004;4867.148249056414;4956.851294461163;4993.375828021497;5022.773975171117;5039.874003149914;4838.298446725223;4857.368542089533;4857.9757101214445;4877.268409738541;4926.236433352827;3840.3855383138703;3885.7862817545024;3913.3347330953666;3945.684345252373;3970.424288478169;3886.4753258310047;3917.138229589486;3954.5056867891512;3957.544882338539;3974.602539746031;3704.499892514503;3785.0537365658583;3834.041489627593;3856.595057518962;3884.961150388502;3861.0540417597585;3876.127871228965;3886.6890648748317;3887.5723670396233;3897.376419772837;3322.4517954537714;3354.9496757548654;3389.847456864447;3411.4030044742317;3426.00645812714;4565.406497155349;4828.299896514985;4836.85489435314;4903.166461701519;4907.901841963177;4184.958150418487;4287.849925252601;4287.978560107211;4294.205571969195;4313.84901528445;5201.921971170435;5204.869878253036;5278.894422111536;5283.86790330241;5287.074761916688;3617.240379520304;3623.365910965597;3625.583057948343;3626.9274614507826;3627.038834708804;5429.185622156669;5438.53772429344;5442.210879422461;5520.199571062173;5529.281193444866;3546.3438180331423;3686.0416291764336;3691.53855768029;3695.279420513028;3696.168362118502;3717;3764.153065560227;3765.2281282337053;3779.055236190952;3835.0412396900774;4318.244307246219;4327.8485253016;4331.285337919271;4333.978330108393;4387.517373088957;5220.295260139908;5228.320318358665;5233.345831771028;5274.709890955957;5302.125149350391;1342.8992825538123;1362.284800479756;1363.1003537665094;1364.106510235797;1366.8496465388798;870.3733312015339;889.1464194373344;892.8125093730389;901.5492253873064;905.8641203819479;4966.925496117561;4979.278004689299;4995.650304478724;5027.899442011212;5035.043341765053;5423.078076726966;5429.131338985743;5431.565474762009;5478.506934375846;5508.20131080991;4811.3745213122775;4949.505049495022;4999.200127979506;5032.949670503322;5081.161608334583;2804.5372513535444;2936.0751363320487;2941.9411611767646;2951.7638588912837;2996.745276651509;5362.3565172178805;5434.130539113723;5453.754581043862;5464.480874316933;5502.367227768777;5466.644668096561;5530.723463826793;5557.722113894289;5566.2207290979295;5579.7489112990015;5436.782528698887;5455.399906010256;5490.917636235459;5510.476504732044;5517.420670829505;5345.492178243061;5433.538149257357;5441.455854414527;5455.481729235717;5576.414476479911;5342.3856256531;5381.919271210857;5431.972840135774;5438.646487978269;5439.972800135974;5504.80733174337;5546.667199968015;5563.721813909369;5564.610477266714;5584.832455026356;3636.618155093677;3647.6170002149393;3691.3540130477595;3697.500837387026;3698.63013698628;5288.8413347599635;5477.452254774491;5489.58828087887;5512.889742205213;5519.972400137974;5275.920861187008;5318.627696061393;5345.358556973188;5357.973210134081;5366.1145910925825;5282.392524859537;5289.312389389509;5310.044192045469;5337.8131765388025;5358.517733404013;4962.206047032458;5137.049645815536;5162.199859021857;5224.6342756008235;5239.05696974533;5238.947610523998;5301.310829592283;5308.389535203501;5312.150055991023;5340;4962.478939711278;5066.44269130388;5135.563477104488;5165.845024649267;5234.319538460129 12:19:58 INFO - 2015-11-02 12:19:58,910 DEBUG : BROWSER_OUTPUT: |5;yui.html;572.8281515545335;605.9454649081582;623.199189042081;646.1696719715167;667.6561570791043;11155.219134660567;11599.912015837146;11611.187216894821;11711.941440292787;11776.116791240649;10768.838467422995;10828.566857325697;10831.29596576222;10934;11015.118790496761;565.21435205065;583.5769067426104;583.6614763437196;681.2063945503483;719.9424046076327;686.1663079358578;704.2183176673888;708.0901042160824;710.6162672157055;710.7157137145132;720.6792977125182;733.3876213361823;733.8752412089957;734.3721118443707;734.7501849371213;577.5697105656292;586.4926838284874;751.9060117485315;784.0160598448911;789.2896393246067;545.2775073028254;555.0370107862855;559.3958524793254;562.2746656812707;564.3369041376367;11207.66377008691;11235.157363197794;11294.435278236055;11430.485628146671;11444.542218311257;9561.521923903778;9704.272179586489;9781.951090244575;10108.090271875566;10220.74448138795;7448.851022979564;7703.6918523259;7709.38324934004;7781.748678486409;7792.68498565001;2680.070349348466;2685.3018215264174;2745.6567929008875;2806.3545384561667;2871.61233233515;41125.38311925324;41734;41917.16165676669;42673.146537069086;43483.78258108689;7226.927730722626;7481;7554;7581;7595.202503737139;15662.921685391728;15849.128297943724;15887.17297510778;15897.52307430779;15920.124393158256;5617.887642247214;5686.545076393879;5845.123231515222;5972.402759723993;5974.9402505974385;3201.5037669161316;3231.5152727091127;3245.1562593725803;3276.967230327666;3286.2113092857544;2604.4921240358326;2631.210636808988;2640.07597340933;2656.2164161571995;2670.198940317897;350.20678163958655;355.80626996426616;361.16570721632587;366.2363971120244;368.82480821610056;435.42306443961877;462.30423213064125;467.18942634529066;471.2224829032056;491.39314441775196;6164.198654174928;6224;6225.875482490324;6252.093446450239;6355.1420558224045;397.87466947911315;426.36471657231124;431.91158281131374;454.09576573011344;467.1731036066144;2830.1886792452847;2906.287959449948;2922.0795449433363;2986.3579330443627;3098.0550931965518;46970.76514617405;47126;47425;47550;47698;41128;41406.58593414087;43561.782191088845;44200.77899610481;44394;39222;39678.404823927085;39727.60272397297;39734.40398394026;39917;5947.910781338197;5951.523878089829;5984.850378740566;6031.909521357271;6100.694965251809;28162.85918570394;28380;29190.27024324409;29296.853515732284;29446.11661650154;36715.44926826153;36724.63275367319;36844.63155368519;36916.07709807276;38084.428733568464;5248.134057880559;5487.75305111263;5524.806631767869;5749.8275051748515;5836.328822185334;8338.332933365438;8551.401401901807;8577;8609.956950215459;8632.093630168742;7994.760157195061;8016.4388492807275;8110.432269741062;8139.14538973423;8164.632591533514;7764.029496312961;7790.454668173174;7942.126366099609;8087.110417854149;8406.495610263159;7730.497517661334;7766.689332426639;7868.173841746534;7975.441719079608;7988.400869934662;6483.481321494175;6829.112215411965;7013;7014.5440546364325;7205.668659086391;6681.432078273207;7188.353048225685;7437.219091995263;7438.330550250504;7460.66427010775 12:19:58 INFO - 2015-11-02 12:19:58,910 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:19:58 INFO - 2015-11-02 12:19:58,910 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:19:58 INFO - 2015-11-02 12:19:58,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,967 12:19:58 INFO - 2015-11-02 12:19:58,910 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:19:58 INFO - 2015-11-02 12:19:58,911 DEBUG : BROWSER_OUTPUT: __startTimestamp1446495598893__endTimestamp 12:19:58 INFO - 2015-11-02 12:19:58,911 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,911 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:19:58 INFO - 2015-11-02 12:19:58,911 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:19:58 INFO - 2015-11-02 12:19:58,911 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,911 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4374.97 Median:4517.62 stddev:454.82 (10.1%) stddev-sans-first:432.79 12:19:58 INFO - 2015-11-02 12:19:58,912 DEBUG : BROWSER_OUTPUT: Values: 2538.5 2627.4 2631.4 2647.9 2675.6 4241.4 4353.7 4418.0 4469.6 4499.6 4362.0 4363.2 4399.5 4457.8 4493.9 4099.4 4119.9 4129.7 4193.5 4211.7 4175.7 4196.4 4226.5 4262.3 4288.5 4054.3 4168.4 4188.3 4191.2 4227.7 4032.5 4101.8 4112.6 4114.7 4119.5 4135.5 4153.5 4168.4 4173.7 4216.4 4175.1 4296.1 4303.6 4364.8 4399.5 4513.4 4560.0 4589.0 4598.9 4617.6 4638.6 4644.3 4692.4 4713.5 4813.0 4199.7 4283.2 4402.4 4411.8 4430.5 4638.7 4755.2 4794.6 4835.6 4903.5 4549.2 4550.1 4556.8 4599.6 4673.4 4553.5 4559.3 4661.0 4670.7 4731.6 4533.1 4567.5 4584.1 4644.6 4648.8 4611.5 4690.3 4710.5 4736.0 4776.2 3463.6 3549.6 3601.3 3614.3 3677.6 3200.5 3232.2 3300.8 3332.4 3370.3 4366.1 4386.9 4387.1 4473.9 4510.0 4524.0 4681.3 4737.2 4750.7 4824.2 4261.4 4347.3 4365.5 4390.2 4435.2 4107.2 4118.1 4130.6 4207.1 4259.7 4564.2 4731.9 4762.4 4797.2 4907.0 4604.6 4665.3 4716.2 4717.3 4717.5 4723.0 4746.5 4792.1 4837.4 4862.2 4449.1 4563.4 4693.6 4703.2 4783.7 4539.5 4616.2 4707.2 4748.8 4751.0 4547.1 4581.7 4664.9 4672.7 4694.8 4470.6 4563.5 4597.7 4597.7 4638.6 4329.1 4470.9 4517.6 4522.1 4530.7 4577.0 4588.6 4649.0 4687.5 4695.7 4348.3 4473.6 4542.8 4568.0 4608.8 12:19:58 INFO - 2015-11-02 12:19:58,912 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,912 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37610.61 Median:28274.79 stddev:62625.49 (221.5%) stddev-sans-first:62738.93 12:19:58 INFO - 2015-11-02 12:19:58,912 DEBUG : BROWSER_OUTPUT: Values: 424.2 436.0 438.1 443.2 471.6 25906.5 26561.2 32177.0 32898.0 33173.2 34185.7 34386.0 34386.3 34445.0 34912.8 6686.3 7493.0 7662.2 7673.1 7693.4 6710.8 6903.0 8737.7 8914.4 8940.2 8842.6 8876.1 8881.1 8925.2 9025.5 6858.1 6990.8 8718.3 8788.8 8832.2 6699.5 8965.3 9174.3 9183.1 9193.7 32413.4 32802.5 32814.8 32820.8 33312.8 2504.0 2514.0 2527.0 2800.6 2960.7 21804.1 21838.5 22287.9 22426.6 23082.7 1900.8 1901.8 1906.2 1940.5 1955.6 232353.0 233909.0 237150.0 237763.0 238159.0 40392.8 41245.8 41291.2 47762.0 48132.5 49545.5 50052.7 50409.2 50415.7 51078.2 13508.1 13654.6 13689.4 13932.3 13948.2 10334.4 10526.5 10583.8 10692.7 10709.9 15229.8 15382.2 15464.1 15517.5 15671.1 6951.9 6972.2 7097.4 7155.7 7200.9 701.0 715.5 777.0 824.9 828.8 23049.8 23491.3 23572.8 23608.3 23876.4 779.7 836.8 856.4 904.0 990.7 11081.1 11208.6 11272.0 11279.2 11305.8 251679.0 251749.0 256206.0 257821.0 257840.0 41962.8 41999.0 42002.4 42248.0 42275.0 989.4 1024.0 1026.4 1107.5 1132.9 17286.0 21371.3 22116.9 22181.2 22583.2 40908.8 41443.4 41628.8 41652.4 42057.2 221486.0 224249.0 229065.0 231167.0 232308.0 24789.6 25254.6 25351.5 25581.9 25672.0 32891.0 32989.8 33014.2 33048.8 33359.7 27320.7 27428.9 28031.3 28144.7 28264.9 27494.3 27512.4 27649.0 27880.2 28057.0 27754.7 28284.7 28486.9 28879.0 28916.4 23838.5 24564.8 24672.9 24870.0 25613.7 19159.3 19171.0 19289.7 19371.7 19762.8 12:19:58 INFO - 2015-11-02 12:19:58,913 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,913 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23541.22 Median:4262.62 stddev:71360.31 (1674.1%) stddev-sans-first:71539.12 12:19:58 INFO - 2015-11-02 12:19:58,914 DEBUG : BROWSER_OUTPUT: Values: 277.5 278.3 279.8 283.3 285.0 13717.4 14343.5 14470.1 14507.9 15051.8 14179.9 14863.4 14875.5 15110.2 15203.4 4339.1 4372.0 4470.4 4494.8 4525.7 4420.3 4465.7 4490.7 4511.9 4520.8 3155.2 3243.0 3321.5 4420.2 4492.0 4722.4 4898.8 4921.1 4931.5 4972.6 4135.3 4260.6 4262.0 4263.3 4277.7 14010.9 14529.1 15006.8 16538.9 17734.7 1656.9 1690.3 1701.6 1706.4 1735.2 10985.7 11082.6 11149.8 11371.1 11393.3 1324.7 1396.4 1405.7 1411.6 1487.7 47981.3 48301.3 49056.3 49594.3 49617.0 7861.1 7870.6 7913.5 8172.6 8237.8 9944.0 9945.9 9978.4 9978.6 9980.6 6699.8 6703.4 6771.4 6777.3 6830.5 6923.2 6971.1 6992.2 7054.7 7056.3 4853.9 4880.3 4913.9 4972.2 4981.3 1377.4 1402.2 1406.6 1413.7 1434.6 708.0 755.3 768.1 779.7 869.1 14919.6 15432.5 15531.7 15580.4 15631.7 655.2 743.7 774.9 774.9 842.8 6976.3 8467.7 8831.2 8905.8 9040.9 434151.0 435528.4 436584.0 441628.0 442389.0 53259.5 54916.7 55802.7 55995.7 56591.0 827.8 850.9 874.1 881.8 887.7 13631.7 13810.2 14022.9 14038.7 14059.0 27475.9 28273.0 28472.7 28708.3 28881.1 37680.4 38083.0 38243.6 38646.2 38646.8 7486.8 7554.0 7717.6 7763.9 7792.2 14625.3 14800.0 14860.1 15379.6 15535.3 11797.2 12084.5 12133.2 12248.9 12424.3 11597.3 11630.8 12025.7 12081.1 12354.6 12207.3 12253.9 12586.9 12902.5 13009.5 7530.0 7569.2 7597.7 7620.7 7717.5 11833.3 12183.1 12234.9 12263.8 12400.9 12:19:58 INFO - 2015-11-02 12:19:58,914 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,914 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4302.89 Median:5418.51 stddev:2219.46 (41.0%) stddev-sans-first:2213.50 12:19:58 INFO - 2015-11-02 12:19:58,916 DEBUG : BROWSER_OUTPUT: Values: 1208.2 1302.5 1401.3 1404.7 1467.0 5750.8 6033.2 6078.5 6175.3 6182.8 6126.3 6231.0 6288.5 6294.3 6382.8 1777.7 1800.6 1801.4 1806.8 1808.2 1795.0 1809.0 1815.9 1822.0 1839.7 1737.1 1749.2 1752.3 1752.7 1753.2 1738.2 1750.6 1773.5 1782.7 1784.1 1778.0 1796.6 1807.9 1811.5 1813.4 5602.1 6213.9 6248.1 6255.7 6274.9 3569.6 3662.6 3721.1 3805.0 3857.9 2223.2 2274.2 2289.4 2304.7 2330.8 653.2 663.5 672.7 1211.3 1259.2 8117.9 8196.1 8202.3 8325.4 8389.3 3305.8 3310.4 3359.3 3363.7 3414.7 6793.9 6805.9 6829.7 6831.8 6880.7 3788.9 3802.1 3804.5 3823.3 3842.4 3515.4 3517.6 3523.1 3539.8 3559.3 2730.8 2735.4 2758.9 2774.6 2784.5 782.4 788.6 789.8 790.7 831.8 1025.9 1052.2 1063.6 1064.5 1098.0 6003.6 6010.2 6014.3 6021.1 6022.3 366.7 372.5 374.8 377.1 378.6 4756.6 4801.4 4818.9 4822.7 4885.4 6891.4 7017.3 7040.7 7173.3 7235.1 7224.7 7255.8 7267.5 7332.8 7347.2 5587.2 5619.2 5666.3 5745.6 5787.1 5746.2 5757.2 5763.5 5772.3 5772.6 6291.5 6440.0 6460.2 6514.2 6518.7 6491.0 6648.5 6652.9 6656.7 6656.8 5224.9 5292.2 5300.2 5301.1 5306.4 6012.0 6052.1 6072.7 6076.8 6128.2 5499.2 5640.9 5676.8 5739.1 5740.7 5484.1 5558.4 5640.6 5659.7 5664.1 5478.0 5754.9 5756.8 5759.0 5842.8 4997.4 5225.8 5228.1 5233.0 5292.1 4982.7 5333.1 5376.8 5401.4 5435.6 12:19:58 INFO - 2015-11-02 12:19:58,916 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,918 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4397.59 Median:5010.99 stddev:1315.57 (26.3%) stddev-sans-first:1281.95 12:19:58 INFO - 2015-11-02 12:19:58,918 DEBUG : BROWSER_OUTPUT: Values: 252.9 263.1 263.8 265.4 265.5 4867.1 4956.9 4993.4 5022.8 5039.9 4838.3 4857.4 4858.0 4877.3 4926.2 3840.4 3885.8 3913.3 3945.7 3970.4 3886.5 3917.1 3954.5 3957.5 3974.6 3704.5 3785.1 3834.0 3856.6 3885.0 3861.1 3876.1 3886.7 3887.6 3897.4 3322.5 3354.9 3389.8 3411.4 3426.0 4565.4 4828.3 4836.9 4903.2 4907.9 4185.0 4287.8 4288.0 4294.2 4313.8 5201.9 5204.9 5278.9 5283.9 5287.1 3617.2 3623.4 3625.6 3626.9 3627.0 5429.2 5438.5 5442.2 5520.2 5529.3 3546.3 3686.0 3691.5 3695.3 3696.2 3717.0 3764.2 3765.2 3779.1 3835.0 4318.2 4327.8 4331.3 4334.0 4387.5 5220.3 5228.3 5233.3 5274.7 5302.1 1342.9 1362.3 1363.1 1364.1 1366.8 870.4 889.1 892.8 901.5 905.9 4966.9 4979.3 4995.7 5027.9 5035.0 5423.1 5429.1 5431.6 5478.5 5508.2 4811.4 4949.5 4999.2 5032.9 5081.2 2804.5 2936.1 2941.9 2951.8 2996.7 5362.4 5434.1 5453.8 5464.5 5502.4 5466.6 5530.7 5557.7 5566.2 5579.7 5436.8 5455.4 5490.9 5510.5 5517.4 5345.5 5433.5 5441.5 5455.5 5576.4 5342.4 5381.9 5432.0 5438.6 5440.0 5504.8 5546.7 5563.7 5564.6 5584.8 3636.6 3647.6 3691.4 3697.5 3698.6 5288.8 5477.5 5489.6 5512.9 5520.0 5275.9 5318.6 5345.4 5358.0 5366.1 5282.4 5289.3 5310.0 5337.8 5358.5 4962.2 5137.0 5162.2 5224.6 5239.1 5238.9 5301.3 5308.4 5312.2 5340.0 4962.5 5066.4 5135.6 5165.8 5234.3 12:19:58 INFO - 2015-11-02 12:19:58,918 DEBUG : BROWSER_OUTPUT: 12:19:58 INFO - 2015-11-02 12:19:58,918 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11106.22 Median:3039.92 stddev:13572.77 (446.5%) stddev-sans-first:13587.79 12:19:58 INFO - 2015-11-02 12:19:58,919 DEBUG : BROWSER_OUTPUT: Values: 572.8 605.9 623.2 646.2 667.7 11155.2 11599.9 11611.2 11711.9 11776.1 10768.8 10828.6 10831.3 10934.0 11015.1 565.2 583.6 583.7 681.2 719.9 686.2 704.2 708.1 710.6 710.7 720.7 733.4 733.9 734.4 734.8 577.6 586.5 751.9 784.0 789.3 545.3 555.0 559.4 562.3 564.3 11207.7 11235.2 11294.4 11430.5 11444.5 9561.5 9704.3 9782.0 10108.1 10220.7 7448.9 7703.7 7709.4 7781.7 7792.7 2680.1 2685.3 2745.7 2806.4 2871.6 41125.4 41734.0 41917.2 42673.1 43483.8 7226.9 7481.0 7554.0 7581.0 7595.2 15662.9 15849.1 15887.2 15897.5 15920.1 5617.9 5686.5 5845.1 5972.4 5974.9 3201.5 3231.5 3245.2 3277.0 3286.2 2604.5 2631.2 2640.1 2656.2 2670.2 350.2 355.8 361.2 366.2 368.8 435.4 462.3 467.2 471.2 491.4 6164.2 6224.0 6225.9 6252.1 6355.1 397.9 426.4 431.9 454.1 467.2 2830.2 2906.3 2922.1 2986.4 3098.1 46970.8 47126.0 47425.0 47550.0 47698.0 41128.0 41406.6 43561.8 44200.8 44394.0 39222.0 39678.4 39727.6 39734.4 39917.0 5947.9 5951.5 5984.9 6031.9 6100.7 28162.9 28380.0 29190.3 29296.9 29446.1 36715.4 36724.6 36844.6 36916.1 38084.4 5248.1 5487.8 5524.8 5749.8 5836.3 8338.3 8551.4 8577.0 8610.0 8632.1 7994.8 8016.4 8110.4 8139.1 8164.6 7764.0 7790.5 7942.1 8087.1 8406.5 7730.5 7766.7 7868.2 7975.4 7988.4 6483.5 6829.1 7013.0 7014.5 7205.7 6681.4 7188.4 7437.2 7438.3 7460.7 12:19:58 INFO - 2015-11-02 12:19:58,919 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:19:58 INFO - 2015-11-02 12:19:58,920 DEBUG : BROWSER_OUTPUT: 12:19:59 INFO - 2015-11-02 12:19:59,635 INFO : Browser exited with error code: 0 12:19:59 INFO - 2015-11-02 12:19:59,668 INFO : Completed test dromaeo_css (00:18:36) 12:19:59 INFO - 2015-11-02 12:19:59,668 INFO : Starting test kraken 12:19:59 INFO - 2015-11-02 12:19:59,668 DEBUG : operating with platform_type : mac_ 12:19:59 INFO - 2015-11-02 12:19:59,668 INFO : Initialising browser for kraken test... 12:19:59 INFO - 2015-11-02 12:19:59,685 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpsLq27r/profile http://localhost:51663/getInfo.html 12:20:02 INFO - 2015-11-02 12:20:02,280 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:20:02 INFO - 2015-11-02 12:20:02,280 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:20:02 INFO - 2015-11-02 12:20:02,280 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:20:02 INFO - 2015-11-02 12:20:02,280 DEBUG : BROWSER_OUTPUT: __metrics 12:20:02 INFO - 2015-11-02 12:20:02,301 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:20:03 INFO - 2015-11-02 12:20:03,147 INFO : Browser initialized. 12:20:03 INFO - 2015-11-02 12:20:03,147 INFO : Running cycle 1/1 for kraken test... 12:20:03 INFO - 2015-11-02 12:20:03,147 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpsLq27r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:20:15 INFO - 2015-11-02 12:20:15,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 222081024 12:20:15 INFO - 2015-11-02 12:20:15,324 DEBUG : BROWSER_OUTPUT: 12:20:18 INFO - 2015-11-02 12:20:18,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51663/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:18 INFO - 2015-11-02 12:20:18,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 277790720 12:20:18 INFO - 2015-11-02 12:20:18,871 DEBUG : BROWSER_OUTPUT: 12:20:22 INFO - 2015-11-02 12:20:22,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51663/tests/kraken/driver.html?testName=audio-dft) 12:20:22 INFO - 2015-11-02 12:20:22,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 292364288 12:20:22 INFO - 2015-11-02 12:20:22,618 DEBUG : BROWSER_OUTPUT: 12:20:26 INFO - 2015-11-02 12:20:26,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51663/tests/kraken/driver.html?testName=audio-fft) 12:20:26 INFO - 2015-11-02 12:20:26,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 274472960 12:20:26 INFO - 2015-11-02 12:20:26,693 DEBUG : BROWSER_OUTPUT: 12:20:29 INFO - 2015-11-02 12:20:29,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51663/tests/kraken/driver.html?testName=audio-oscillator) 12:20:29 INFO - 2015-11-02 12:20:29,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 276258816 12:20:29 INFO - 2015-11-02 12:20:29,597 DEBUG : BROWSER_OUTPUT: 12:20:32 INFO - 2015-11-02 12:20:32,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:20:32 INFO - 2015-11-02 12:20:32,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 277823488 12:20:32 INFO - 2015-11-02 12:20:32,730 DEBUG : BROWSER_OUTPUT: 12:20:36 INFO - 2015-11-02 12:20:36,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51663/tests/kraken/driver.html?testName=imaging-darkroom) 12:20:36 INFO - 2015-11-02 12:20:36,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 275116032 12:20:36 INFO - 2015-11-02 12:20:36,964 DEBUG : BROWSER_OUTPUT: 12:20:40 INFO - 2015-11-02 12:20:40,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51663/tests/kraken/driver.html?testName=imaging-desaturate) 12:20:41 INFO - 2015-11-02 12:20:41,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 272715776 12:20:41 INFO - 2015-11-02 12:20:41,333 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2015-11-02 12:20:44,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51663/tests/kraken/driver.html?testName=json-parse-financial) 12:20:45 INFO - 2015-11-02 12:20:45,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 274632704 12:20:45 INFO - 2015-11-02 12:20:45,371 DEBUG : BROWSER_OUTPUT: 12:20:47 INFO - 2015-11-02 12:20:47,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:20:47 INFO - 2015-11-02 12:20:47,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 310779904 12:20:47 INFO - 2015-11-02 12:20:47,716 DEBUG : BROWSER_OUTPUT: 12:20:49 INFO - 2015-11-02 12:20:49,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:20:50 INFO - 2015-11-02 12:20:50,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 312983552 12:20:50 INFO - 2015-11-02 12:20:50,433 DEBUG : BROWSER_OUTPUT: 12:20:52 INFO - 2015-11-02 12:20:52,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:20:53 INFO - 2015-11-02 12:20:53,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 320053248 12:20:53 INFO - 2015-11-02 12:20:53,448 DEBUG : BROWSER_OUTPUT: 12:20:56 INFO - 2015-11-02 12:20:56,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:20:57 INFO - 2015-11-02 12:20:57,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 321318912 12:20:57 INFO - 2015-11-02 12:20:57,121 DEBUG : BROWSER_OUTPUT: 12:21:00 INFO - 2015-11-02 12:21:00,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:21:00 INFO - 2015-11-02 12:21:00,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 320028672 12:21:00 INFO - 2015-11-02 12:21:00,787 DEBUG : BROWSER_OUTPUT: 12:21:02 INFO - 2015-11-02 12:21:02,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51663/tests/kraken/driver.html?testName=ai-astar) 12:21:03 INFO - 2015-11-02 12:21:03,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 380796928 12:21:03 INFO - 2015-11-02 12:21:03,029 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,029 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:21:03 INFO - 2015-11-02 12:21:03,029 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:21:03 INFO - 2015-11-02 12:21:03,029 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |0;ai-astar;129;126;132;139;140;135;135;132;134;132 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;191;168;192;207;164;187;179;155;207;165 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |2;audio-dft;199;207;206;196;197;197;208;208;197;197 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;102;109;108;87;89;90;102;107;81 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;118;121;168;114;115;113;158;109;110;162 12:21:03 INFO - 2015-11-02 12:21:03,030 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;142;142;155;146;141;142;148;155;149 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;154;162;159;154;154;154;163;161;154;154 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;125;130;129;136;136;129;130;130;127;123 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;68;69;73;70;72;71;80;74;72 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;82;85;83;85;85;84;88;88;88 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;108;111;111;109;113;109;105;106;107 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;167;167;165;159;166;159;157;161;154;156 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;182;188;202;187;185;183;185;182;188;187 12:21:03 INFO - 2015-11-02 12:21:03,031 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;85;86;87;87;91;90;90;91;86 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1021 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: __startTimestamp1446495663022__endTimestamp 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:21:03 INFO - 2015-11-02 12:21:03,032 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:133.40 Median:134.50 stddev:4.22 (3.1%) stddev-sans-first:4.17 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: Values: 129.0 126.0 132.0 139.0 140.0 135.0 135.0 132.0 134.0 132.0 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.50 Median:189.00 stddev:18.26 (9.7%) stddev-sans-first:19.04 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: Values: 191.0 168.0 192.0 207.0 164.0 187.0 179.0 155.0 207.0 165.0 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:201.20 Median:202.50 stddev:5.29 (2.6%) stddev-sans-first:5.55 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: Values: 199.0 207.0 206.0 196.0 197.0 197.0 208.0 208.0 197.0 197.0 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,033 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:96.10 Median:83.50 stddev:10.52 (12.6%) stddev-sans-first:10.51 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: Values: 86.0 102.0 109.0 108.0 87.0 89.0 90.0 102.0 107.0 81.0 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:128.80 Median:119.50 stddev:23.74 (19.9%) stddev-sans-first:24.86 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: Values: 118.0 121.0 168.0 114.0 115.0 113.0 158.0 109.0 110.0 162.0 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:146.90 Median:148.50 stddev:5.26 (3.5%) stddev-sans-first:5.52 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: Values: 149.0 142.0 142.0 155.0 146.0 141.0 142.0 148.0 155.0 149.0 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:156.90 Median:156.50 stddev:3.87 (2.5%) stddev-sans-first:3.96 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: Values: 154.0 162.0 159.0 154.0 154.0 154.0 163.0 161.0 154.0 154.0 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,034 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:129.50 Median:130.00 stddev:4.14 (3.2%) stddev-sans-first:4.06 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: Values: 125.0 130.0 129.0 136.0 136.0 129.0 130.0 130.0 127.0 123.0 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:72.00 stddev:4.19 (5.8%) stddev-sans-first:3.52 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: Values: 64.0 68.0 69.0 73.0 70.0 72.0 71.0 80.0 74.0 72.0 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:84.80 Median:85.00 stddev:2.70 (3.2%) stddev-sans-first:2.24 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 85.0 83.0 85.0 85.0 84.0 88.0 88.0 88.0 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:108.20 Median:109.00 stddev:3.05 (2.8%) stddev-sans-first:2.59 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: Values: 103.0 108.0 111.0 111.0 109.0 113.0 109.0 105.0 106.0 107.0 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:161.10 Median:163.00 stddev:4.84 (3.0%) stddev-sans-first:4.64 12:21:03 INFO - 2015-11-02 12:21:03,035 DEBUG : BROWSER_OUTPUT: Values: 167.0 167.0 165.0 159.0 166.0 159.0 157.0 161.0 154.0 156.0 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:187.00 stddev:5.78 (3.1%) stddev-sans-first:5.85 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: Values: 182.0 188.0 202.0 187.0 185.0 183.0 185.0 182.0 188.0 187.0 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.30 Median:88.50 stddev:3.40 (3.8%) stddev-sans-first:2.37 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: Values: 80.0 85.0 86.0 87.0 87.0 91.0 90.0 90.0 91.0 86.0 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:21:03 INFO - 2015-11-02 12:21:03,036 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-02 12:21:03,780 INFO : Browser exited with error code: 0 12:21:03 INFO - 2015-11-02 12:21:03,840 INFO : Completed test kraken (00:01:04) 12:21:03 INFO - 2015-11-02 12:21:03,840 INFO : Starting test v8_7 12:21:03 INFO - 2015-11-02 12:21:03,841 DEBUG : operating with platform_type : mac_ 12:21:03 INFO - 2015-11-02 12:21:03,841 INFO : Initialising browser for v8_7 test... 12:21:03 INFO - 2015-11-02 12:21:03,857 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpCRbEB3/profile http://localhost:51663/getInfo.html 12:21:06 INFO - 2015-11-02 12:21:06,484 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:21:06 INFO - 2015-11-02 12:21:06,484 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:21:06 INFO - 2015-11-02 12:21:06,485 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:21:06 INFO - 2015-11-02 12:21:06,485 DEBUG : BROWSER_OUTPUT: __metrics 12:21:06 INFO - 2015-11-02 12:21:06,501 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:21:07 INFO - 2015-11-02 12:21:07,322 INFO : Browser initialized. 12:21:07 INFO - 2015-11-02 12:21:07,322 INFO : Running cycle 1/1 for v8_7 test... 12:21:07 INFO - 2015-11-02 12:21:07,322 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpCRbEB3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:21:19 INFO - 2015-11-02 12:21:19,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 220856320 12:21:19 INFO - 2015-11-02 12:21:19,429 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51663/tests/v8_7/run.html (next: http://localhost:51663/tests/v8_7/run.html) 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 680505344 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: |0;Richards;201.4098690835851 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;246.9745616201531 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: |2;Encrypt;390.32006245121 12:21:42 INFO - 2015-11-02 12:21:42,282 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7120.567375886525 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2551.0204081632655 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: |5;Earley;982.3182711198428 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: |6;Boyer;16241.935483870968 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: |7;RegExp;36745.454545454544 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: |8;Splay;831.9536423841059 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7084.507042253521 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: __startTimestamp1446495702276__endTimestamp 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:21:42 INFO - 2015-11-02 12:21:42,283 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:201.41 Median:201.41 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: Values: 201.4 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:246.97 Median:246.97 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: Values: 247.0 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:390.32 Median:390.32 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: Values: 390.3 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7120.57 Median:7120.57 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: Values: 7120.6 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,284 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2551.02 Median:2551.02 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: Values: 2551.0 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:982.32 Median:982.32 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: Values: 982.3 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16241.94 Median:16241.94 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: Values: 16241.9 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36745.45 Median:36745.45 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: Values: 36745.5 12:21:42 INFO - 2015-11-02 12:21:42,285 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:831.95 Median:831.95 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: Values: 832.0 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7084.51 Median:7084.51 stddev:0.00 (0.0%) 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: Values: 7084.5 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:21:42 INFO - 2015-11-02 12:21:42,286 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2015-11-02 12:21:43,100 INFO : Browser exited with error code: 0 12:21:43 INFO - 2015-11-02 12:21:43,125 INFO : Completed test v8_7 (00:00:39) 12:21:43 INFO - 2015-11-02 12:21:43,279 INFO : Completed test suite (00:20:19) 12:21:43 INFO - 2015-11-02 12:21:43,279 DEBUG : Working with test: dromaeo_css 12:21:43 INFO - 2015-11-02 12:21:43,279 DEBUG : Generating results file: dromaeo_css 12:21:43 INFO - 2015-11-02 12:21:43,280 DEBUG : Working with test: kraken 12:21:43 INFO - 2015-11-02 12:21:43,280 DEBUG : Generating results file: kraken 12:21:43 INFO - 2015-11-02 12:21:43,280 INFO : javascript benchmark 12:21:43 INFO - 2015-11-02 12:21:43,281 DEBUG : Working with test: v8_7 12:21:43 INFO - 2015-11-02 12:21:43,281 DEBUG : Generating results file: v8_7 12:21:43 INFO - 2015-11-02 12:21:43,281 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:43 INFO - 2015-11-02 12:21:43,334 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 12:21:43 INFO - 2015-11-02 12:21:43,334 DEBUG : process_Request line: dromaeo_css 5644.81 graph.html#tests=[[72,63,55]] 12:21:43 INFO - 2015-11-02 12:21:43,334 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:43 INFO - 2015-11-02 12:21:43,362 DEBUG : process_Request line: kraken 1873.90 graph.html#tests=[[232,63,55]] 12:21:43 INFO - 2015-11-02 12:21:43,362 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:43 INFO - 2015-11-02 12:21:43,395 DEBUG : process_Request line: v8_7 14841.21 graph.html#tests=[[230,63,55]] 12:21:43 INFO - 2015-11-02 12:21:43,396 INFO : javascript benchmark 12:21:43 INFO - 2015-11-02 12:21:43,398 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [277.52543151211427, 278.26815475299964, 279.80833129306427, 283.31720553466135, 284.96580410350754, 13717.382717777711, 14343.497977570787, 14470.059446136007, 14507.927460362684, 15051.849481505182, 14179.858201417983, 14863.405463781462, 14875.479358222465, 15110.168940708256, 15203.391864325442, 4339.1104823511105, 4371.956280437194, 4470.396496472983, 4494.775261236941, 4525.660575456837, 4420.270655341865, 4465.665075119363, 4490.685652004345, 4511.887202819923, 4520.841770538032, 3155.2269693924904, 3242.9784617845303, 3321.501774733797, 4420.160169567788, 4491.977540112295, 4722.409698787652, 4898.804047838083, 4921.089598424285, 4931.5068493150575, 4972.627052971042, 4135.29699951009, 4260.595243451867, 4261.957380426187, 4263.275243208662, 4277.657787377002, 14010.92994535031, 14529.128252304896, 15006.774898376532, 16538.917305413517, 17734.733978990327, 1656.850883420498, 1690.2647348403361, 1701.5916180116806, 1706.3942300483398, 1735.1757914990405, 10985.670429887115, 11082.556697732081, 11149.832752508719, 11371.147163962736, 11393.259438136494, 1324.6886981559326, 1396.3995481942761, 1405.6977749783846, 1411.647088227943, 1487.7470829958934, 47981.280280795465, 48301.275480867815, 49056.26415603769, 49594.2560861591, 49617.0, 7861.056673199253, 7870.567118808521, 7913.485623434458, 8172.550509722022, 8237.8352432951, 9943.950280248553, 9945.850812237823, 9978.401295922267, 9978.600855965826, 9980.60077596888, 6699.799006029827, 6703.396694297537, 6771.3905748482875, 6777.254502004874, 6830.521863469509, 6923.2038315594355, 6971.128608923885, 6992.230854605989, 7054.717811287491, 7056.294370563005, 4853.927191092136, 4880.316755654211, 4913.852584422401, 4972.204447288416, 4981.302617633534, 1377.4008306386754, 1402.193738600309, 1406.6413064668648, 1413.7101894111681, 1434.63416828708, 708.0335342257883, 755.2975732568764, 768.0898135709202, 779.7037125892125, 869.0700949983583, 14919.552413427615, 15432.537023889301, 15531.689366212839, 15580.442991939188, 15631.687366252838, 655.1842955520312, 743.6765007221876, 774.8527779721835, 774.9070111586645, 842.7556008757514, 6976.337247961435, 8467.703630373031, 8831.161039701217, 8905.777355566162, 9040.909590904006, 434151.0, 435528.3732161625, 436584.0, 441628.0, 442389.0, 53259.46740532545, 54916.72541637266, 55802.72098639481, 55995.72002139963, 56591.0, 827.8054657155564, 850.9149085091441, 874.1084094223856, 881.8456770065213, 887.6937456577341, 13631.683916821357, 13810.240436776074, 14022.859771402156, 14038.719225615634, 14059.0, 27475.86262068677, 28273.0, 28472.715272847006, 28708.282292942007, 28881.133565993056, 37680.43479347757, 38083.0, 38243.617563825115, 38646.2270754589, 38646.806765965994, 7486.7753967378885, 7554.0, 7717.57553334572, 7763.92236077632, 7792.220777922163, 14625.268736562917, 14800.0, 14860.108393496424, 15379.61550961235, 15535.300911459237, 11797.17419780607, 12084.45619947087, 12133.21134126279, 12248.938755306166, 12424.316662583644, 11597.304161750322, 11630.825537616773, 12025.699357516132, 12081.093917956365, 12354.629361119181, 12207.328596927255, 12253.938730306292, 12586.87413125857, 12902.483900644245, 13009.463154684745, 7530.0, 7569.1673915868105, 7597.696092156473, 7620.69517219305, 7717.536947783151, 11833.290002599872, 12183.147179697691, 12234.877651223374, 12263.816042759187, 12400.937995309965], "dojo.html": [2538.5176816404883, 2627.448235870467, 2631.407933215026, 2647.867606619669, 2675.57190849464, 4241.384999175118, 4353.717008394452, 4417.977910110449, 4469.575390337916, 4499.61753250974, 4361.978190109045, 4363.192809330276, 4399.450068741407, 4457.84397546086, 4493.910121797562, 4099.405586190001, 4119.855805046824, 4129.690273229505, 4193.5387107418155, 4211.68412369072, 4175.686823488235, 4196.412502249687, 4226.4716910386205, 4262.296721041024, 4288.463942007249, 4054.310767169559, 4168.374743788426, 4188.267053265667, 4191.224623444673, 4227.661787057028, 4032.4556184914954, 4101.794910254475, 4112.609302116324, 4114.650254728352, 4119.526254480743, 4135.545090040093, 4153.460050193486, 4168.416421700964, 4173.7495750254775, 4216.430781844473, 4175.06061136245, 4296.140771845643, 4303.634191093761, 4364.825406983717, 4399.5160532341415, 4513.390692256569, 4559.954400456019, 4589.0, 4598.8620341389815, 4617.561331673485, 4638.5593368629925, 4644.303354496818, 4692.389989301403, 4713.481517033124, 4813.03739252151, 4199.706020578591, 4283.164782867373, 4402.449693788277, 4411.823527058914, 4430.468343798765, 4638.675292729544, 4755.215389460769, 4794.568488836021, 4835.588974937099, 4903.4606193318705, 4549.203889319356, 4550.13547425988, 4556.7721613919175, 4599.632029437637, 4673.439187297546, 4553.54464553542, 4559.316102584573, 4660.97669511657, 4670.673052886334, 4731.645126615517, 4533.093381323749, 4567.497575266718, 4584.129015487047, 4644.628429725613, 4648.83729069481, 4611.515790841981, 4690.319903614025, 4710.481846996828, 4735.981763920705, 4776.164171270014, 3463.6363181866045, 3549.5563054618174, 3601.333753255656, 3614.2771445710964, 3677.632236776301, 3200.48792193248, 3232.224266176148, 3300.7854489458587, 3332.4001679697403, 3370.292238629866, 4366.104948485553, 4386.912261754747, 4387.122575484916, 4473.8657840264195, 4510.030343476168, 4524.049949510574, 4681.29780532916, 4737.170995075848, 4750.714957102516, 4824.204006338985, 4261.424707664426, 4347.3261644445165, 4365.541618130114, 4390.165868484977, 4435.2016637005645, 4107.240160570244, 4118.073433477443, 4130.607592278729, 4207.095474473003, 4259.659227261812, 4564.201264778717, 4731.905361892743, 4762.3808904842845, 4797.160496912957, 4906.975465122651, 4604.562566556172, 4665.346851440733, 4716.198246298069, 4717.268823332389, 4717.528247175255, 4723.0081682846985, 4746.525347465364, 4792.0895029944195, 4837.443693975238, 4862.246351815475, 4449.110177964485, 4563.429571303587, 4693.55411235932, 4703.215189495789, 4783.689060211075, 4539.523350048197, 4616.238320677051, 4707.246840505502, 4748.810047598057, 4751.0, 4547.090581883703, 4581.725096494221, 4664.883377915579, 4672.696274742131, 4694.812207511662, 4470.597646211857, 4563.498015218257, 4597.678162528591, 4597.7241365518175, 4638.628909687284, 4329.1341731653165, 4470.932936006027, 4517.616002639681, 4522.095580883903, 4530.660200484911, 4576.977115114536, 4588.587027167571, 4648.953510464988, 4687.507811679725, 4695.671303008757, 4348.2825333819565, 4473.597376236155, 4542.818287268472, 4567.954320456885, 4608.769561521977], "mootools.html": [1208.1663652080058, 1302.5050480817288, 1401.2993503248376, 1404.6542274401747, 1467.0, 5750.798722044729, 6033.155358249843, 6078.513718902488, 6175.289841668209, 6182.845428864281, 6126.26484821822, 6231.003039513679, 6288.465480434169, 6294.339094395092, 6382.776602818903, 1777.7422273770296, 1800.6038671492252, 1801.4055361730598, 1806.8283513066237, 1808.222464340333, 1795.0306834309458, 1808.9819101809012, 1815.8910465372053, 1821.9726704099382, 1839.7332386803905, 1737.0967097109497, 1749.2041121289783, 1752.3165965273554, 1752.7020406530858, 1753.2110550252373, 1738.2351765223325, 1750.5886116762615, 1773.5300145461463, 1782.7236778299384, 1784.0722824131508, 1778.0, 1796.6137280484627, 1807.8553715702844, 1811.529002459357, 1813.4106415415042, 5602.13166959122, 6213.937860621381, 6248.125262463259, 6255.687215639246, 6274.874502509924, 3569.6430356964356, 3662.597114317423, 3721.14413684854, 3805.0, 3857.8842634721004, 2223.1996481266733, 2274.226762900605, 2289.404754763757, 2304.68886700295, 2330.778576035274, 653.1769969838039, 663.515633587479, 672.6804767735287, 1211.3095535544744, 1259.2004077410818, 8117.918820811776, 8196.13940536241, 8202.302804261644, 8325.417220794547, 8389.32885369169, 3305.7851239669826, 3310.3710295043866, 3359.3449277391164, 3363.6972672459597, 3414.7097496712563, 6793.898091528631, 6805.897911531331, 6829.692663830139, 6831.760888368884, 6880.65596720162, 3788.9242215156096, 3802.1065049713297, 3804.4863943367845, 3823.2926908522013, 3842.423636454554, 3515.367233897923, 3517.648235176462, 3523.066387407339, 3539.752217344761, 3559.2703495783303, 2730.754232119119, 2735.4392349568293, 2758.917232483029, 2774.556071028666, 2784.470950519395, 782.4014628808966, 788.5662885413115, 789.7788619186637, 790.7430085222326, 831.846108469935, 1025.933314334566, 1052.1898138433364, 1063.5905176506947, 1064.4571268652887, 1097.9780404391868, 6003.5797494174985, 6010.188624535632, 6014.278286605635, 6021.126936594169, 6022.277326720734, 366.6571755408701, 372.5213101165044, 374.8425661222293, 377.0629984488544, 378.6270523534316, 4756.619470442425, 4801.447833499123, 4818.855434336975, 4822.662413631012, 4885.438174609894, 6891.4486841053595, 7017.333353331425, 7040.683169257396, 7173.318534739192, 7235.095613048369, 7224.711011559584, 7255.782326530212, 7267.491275610657, 7332.816679582947, 7347.155077166088, 5587.245721827501, 5619.241402410704, 5666.291713535808, 5745.626534275259, 5787.131930210502, 5746.224259724883, 5757.193992840922, 5763.510101641407, 5772.278465191851, 5772.567057470623, 6291.528135389955, 6439.967800161156, 6460.192475940507, 6514.1531600891585, 6518.674066296761, 6490.993895946136, 6648.5346025777735, 6652.866942661217, 6656.73373065072, 6656.83357916056, 5224.921626175535, 5292.153255479105, 5300.231466437422, 5301.072312345401, 5306.389765177054, 6012.0, 6052.092186172109, 6072.696365181635, 6076.817695469143, 6128.203333566787, 5499.2060341405, 5640.943590564042, 5676.801311954062, 5739.05305624584, 5740.68426236561, 5484.067708489487, 5558.388577256418, 5640.5769567281795, 5659.660420374791, 5664.0654292043, 5478.0, 5754.9424505754405, 5756.769729210785, 5759.0, 5842.795502157404, 4997.375328083989, 5225.843224703265, 5228.058949389147, 5233.031889100528, 5292.100342941632, 4982.6512144149565, 5333.12003519415, 5376.838694839161, 5401.432849550898, 5435.592330575144], "ext.html": [424.17286291731125, 435.96294314983226, 438.0975191106321, 443.1779049862505, 471.61327711276766, 25906.481870362604, 26561.20316390509, 32177.0, 32898.0, 33173.17067073318, 34185.65814341856, 34386.0, 34386.31227375451, 34445.0, 34912.82543587285, 6686.297938716438, 7492.96253518733, 7662.1571627120975, 7673.117591476996, 7693.384529237675, 6710.832229194285, 6903.033575299462, 8737.694180703676, 8914.375993680445, 8940.19538241558, 8842.602082906253, 8876.068012858621, 8881.067487913773, 8925.152110549487, 9025.458472491671, 6858.142732158481, 6990.790276291719, 8718.34612404069, 8788.824223515494, 8832.249258813008, 6699.464042876558, 8965.327600429928, 9174.311926605531, 9183.08169183083, 9193.724188274362, 32413.351732965446, 32802.50796238035, 32814.83592582046, 32820.83589582061, 33312.83343583291, 2504.0484615846044, 2513.9748602513923, 2527.027094568586, 2800.5519116941396, 2960.6891276416095, 21804.127834886585, 21838.454038649, 22287.888560557254, 22426.55146897053, 23082.65376019361, 1900.7624046994126, 1901.847852171823, 1906.20892329683, 1940.505171181354, 1955.6382069317222, 232353.0, 233909.0, 237150.0, 237763.0, 238159.0, 40392.79803600963, 41245.793771030956, 41291.1741765163, 47762.0, 48132.5186748135, 49545.50454495481, 50052.749736251084, 50409.24386134211, 50415.74792126016, 51078.23382649263, 13508.121972071784, 13654.590362289147, 13689.383977721027, 13932.303384830719, 13948.16311021342, 10334.431606261727, 10526.473676316153, 10583.84124238137, 10692.732681683021, 10709.892901071045, 15229.847701523064, 15382.230888455533, 15464.14947177916, 15517.5344739658, 15671.059736415851, 6951.89572156418, 6972.2330543640155, 7097.396721278646, 7155.713771449084, 7200.855982880313, 700.9509334346546, 715.5456285258898, 776.9883451748228, 824.9152364640479, 828.8342331533718, 23049.769502304764, 23491.295261142193, 23572.7642723574, 23608.29175124749, 23876.40308992289, 779.7154038775806, 836.7740710008385, 856.3662889461878, 903.9909600903907, 990.6631745206664, 11081.058110060736, 11208.607698730506, 11272.014875151424, 11279.154063445274, 11305.773884522263, 251679.0, 251749.0, 256206.0, 257821.0, 257840.0, 41962.79018604948, 41998.96012478522, 42002.369964450554, 42248.0, 42275.0, 989.366805244644, 1023.9744006400049, 1026.3533973596586, 1107.451811353369, 1132.869719982196, 17285.97726453204, 21371.25200618033, 22116.889415552818, 22181.223657171922, 22583.209587664354, 40908.795456022526, 41443.37834932539, 41628.79185604174, 41652.375214371204, 42057.15885682208, 221486.0, 224249.0, 229065.0, 231167.0, 232308.0, 24789.62815557804, 25254.621180682672, 25351.492970140862, 25581.872090639426, 25672.0, 32891.0, 32989.83505082555, 33014.17464563405, 33048.834755826065, 33359.666403336625, 27320.726792731817, 27428.862855685595, 28031.299217519725, 28144.71855281421, 28264.85867570649, 27494.312642184104, 27512.449751005268, 27649.0, 27880.16359509218, 28057.0, 27754.722452775215, 28284.71715282821, 28486.85756571204, 28879.0, 28916.42167156603, 23838.523229534967, 24564.754352456246, 24672.876635616707, 24870.041586692085, 25613.743862561136, 19159.329423470113, 19171.0, 19289.710654340477, 19371.709424358363, 19762.802371976097], "prototype.html": [252.89252067871155, 263.0949533604401, 263.8140111221589, 265.43859736656975, 265.53133718986004, 4867.148249056414, 4956.851294461163, 4993.375828021497, 5022.773975171117, 5039.874003149914, 4838.298446725223, 4857.368542089533, 4857.9757101214445, 4877.268409738541, 4926.236433352827, 3840.3855383138703, 3885.7862817545024, 3913.3347330953666, 3945.684345252373, 3970.424288478169, 3886.4753258310047, 3917.138229589486, 3954.5056867891512, 3957.544882338539, 3974.602539746031, 3704.499892514503, 3785.0537365658583, 3834.041489627593, 3856.595057518962, 3884.961150388502, 3861.0540417597585, 3876.127871228965, 3886.6890648748317, 3887.5723670396233, 3897.376419772837, 3322.4517954537714, 3354.9496757548654, 3389.847456864447, 3411.4030044742317, 3426.00645812714, 4565.406497155349, 4828.299896514985, 4836.85489435314, 4903.166461701519, 4907.901841963177, 4184.958150418487, 4287.849925252601, 4287.978560107211, 4294.205571969195, 4313.84901528445, 5201.921971170435, 5204.869878253036, 5278.894422111536, 5283.86790330241, 5287.074761916688, 3617.240379520304, 3623.365910965597, 3625.583057948343, 3626.9274614507826, 3627.038834708804, 5429.185622156669, 5438.53772429344, 5442.210879422461, 5520.199571062173, 5529.281193444866, 3546.3438180331423, 3686.0416291764336, 3691.53855768029, 3695.279420513028, 3696.168362118502, 3717.0, 3764.153065560227, 3765.2281282337053, 3779.055236190952, 3835.0412396900774, 4318.244307246219, 4327.8485253016, 4331.285337919271, 4333.978330108393, 4387.517373088957, 5220.295260139908, 5228.320318358665, 5233.345831771028, 5274.709890955957, 5302.125149350391, 1342.8992825538123, 1362.284800479756, 1363.1003537665094, 1364.106510235797, 1366.8496465388798, 870.3733312015339, 889.1464194373344, 892.8125093730389, 901.5492253873064, 905.8641203819479, 4966.925496117561, 4979.278004689299, 4995.650304478724, 5027.899442011212, 5035.043341765053, 5423.078076726966, 5429.131338985743, 5431.565474762009, 5478.506934375846, 5508.20131080991, 4811.3745213122775, 4949.505049495022, 4999.200127979506, 5032.949670503322, 5081.161608334583, 2804.5372513535444, 2936.0751363320487, 2941.9411611767646, 2951.7638588912837, 2996.745276651509, 5362.3565172178805, 5434.130539113723, 5453.754581043862, 5464.480874316933, 5502.367227768777, 5466.644668096561, 5530.723463826793, 5557.722113894289, 5566.2207290979295, 5579.7489112990015, 5436.782528698887, 5455.399906010256, 5490.917636235459, 5510.476504732044, 5517.420670829505, 5345.492178243061, 5433.538149257357, 5441.455854414527, 5455.481729235717, 5576.414476479911, 5342.3856256531, 5381.919271210857, 5431.972840135774, 5438.646487978269, 5439.972800135974, 5504.80733174337, 5546.667199968015, 5563.721813909369, 5564.610477266714, 5584.832455026356, 3636.618155093677, 3647.6170002149393, 3691.3540130477595, 3697.500837387026, 3698.63013698628, 5288.8413347599635, 5477.452254774491, 5489.58828087887, 5512.889742205213, 5519.972400137974, 5275.920861187008, 5318.627696061393, 5345.358556973188, 5357.973210134081, 5366.1145910925825, 5282.392524859537, 5289.312389389509, 5310.044192045469, 5337.8131765388025, 5358.517733404013, 4962.206047032458, 5137.049645815536, 5162.199859021857, 5224.6342756008235, 5239.05696974533, 5238.947610523998, 5301.310829592283, 5308.389535203501, 5312.150055991023, 5340.0, 4962.478939711278, 5066.44269130388, 5135.563477104488, 5165.845024649267, 5234.319538460129], "yui.html": [572.8281515545335, 605.9454649081582, 623.199189042081, 646.1696719715167, 667.6561570791043, 11155.219134660567, 11599.912015837146, 11611.187216894821, 11711.941440292787, 11776.116791240649, 10768.838467422995, 10828.566857325697, 10831.29596576222, 10934.0, 11015.118790496761, 565.21435205065, 583.5769067426104, 583.6614763437196, 681.2063945503483, 719.9424046076327, 686.1663079358578, 704.2183176673888, 708.0901042160824, 710.6162672157055, 710.7157137145132, 720.6792977125182, 733.3876213361823, 733.8752412089957, 734.3721118443707, 734.7501849371213, 577.5697105656292, 586.4926838284874, 751.9060117485315, 784.0160598448911, 789.2896393246067, 545.2775073028254, 555.0370107862855, 559.3958524793254, 562.2746656812707, 564.3369041376367, 11207.66377008691, 11235.157363197794, 11294.435278236055, 11430.485628146671, 11444.542218311257, 9561.521923903778, 9704.272179586489, 9781.951090244575, 10108.090271875566, 10220.74448138795, 7448.851022979564, 7703.6918523259, 7709.38324934004, 7781.748678486409, 7792.68498565001, 2680.070349348466, 2685.3018215264174, 2745.6567929008875, 2806.3545384561667, 2871.61233233515, 41125.38311925324, 41734.0, 41917.16165676669, 42673.146537069086, 43483.78258108689, 7226.927730722626, 7481.0, 7554.0, 7581.0, 7595.202503737139, 15662.921685391728, 15849.128297943724, 15887.17297510778, 15897.52307430779, 15920.124393158256, 5617.887642247214, 5686.545076393879, 5845.123231515222, 5972.402759723993, 5974.9402505974385, 3201.5037669161316, 3231.5152727091127, 3245.1562593725803, 3276.967230327666, 3286.2113092857544, 2604.4921240358326, 2631.210636808988, 2640.07597340933, 2656.2164161571995, 2670.198940317897, 350.20678163958655, 355.80626996426616, 361.16570721632587, 366.2363971120244, 368.82480821610056, 435.42306443961877, 462.30423213064125, 467.18942634529066, 471.2224829032056, 491.39314441775196, 6164.198654174928, 6224.0, 6225.875482490324, 6252.093446450239, 6355.1420558224045, 397.87466947911315, 426.36471657231124, 431.91158281131374, 454.09576573011344, 467.1731036066144, 2830.1886792452847, 2906.287959449948, 2922.0795449433363, 2986.3579330443627, 3098.0550931965518, 46970.76514617405, 47126.0, 47425.0, 47550.0, 47698.0, 41128.0, 41406.58593414087, 43561.782191088845, 44200.77899610481, 44394.0, 39222.0, 39678.404823927085, 39727.60272397297, 39734.40398394026, 39917.0, 5947.910781338197, 5951.523878089829, 5984.850378740566, 6031.909521357271, 6100.694965251809, 28162.85918570394, 28380.0, 29190.27024324409, 29296.853515732284, 29446.11661650154, 36715.44926826153, 36724.63275367319, 36844.63155368519, 36916.07709807276, 38084.428733568464, 5248.134057880559, 5487.75305111263, 5524.806631767869, 5749.8275051748515, 5836.328822185334, 8338.332933365438, 8551.401401901807, 8577.0, 8609.956950215459, 8632.093630168742, 7994.760157195061, 8016.4388492807275, 8110.432269741062, 8139.14538973423, 8164.632591533514, 7764.029496312961, 7790.454668173174, 7942.126366099609, 8087.110417854149, 8406.495610263159, 7730.497517661334, 7766.689332426639, 7868.173841746534, 7975.441719079608, 7988.400869934662, 6483.481321494175, 6829.112215411965, 7013.0, 7014.5440546364325, 7205.668659086391, 6681.432078273207, 7188.353048225685, 7437.219091995263, 7438.330550250504, 7460.66427010775]}, "summary": {"suite": 5644.81012468798, "subtests": {"jquery.html": {"filtered": 7436.198634756629, "value": 7436.198634756629}, "dojo.html": {"filtered": 4347.056614483992, "value": 4347.056614483992}, "mootools.html": {"filtered": 3482.4396580720495, "value": 3482.4396580720495}, "ext.html": {"filtered": 14934.964921960536, "value": 14934.964921960536}, "prototype.html": {"filtered": 3964.3694584213727, "value": 3964.3694584213727}, "yui.html": {"filtered": 4853.313316966281, "value": 4853.313316966281}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1446494483, "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": "20151102103507", "branch": "Mozilla-Inbound", "revision": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e"}}, {"talos_counters": {}, "results": {"audio-dft": [199.0, 207.0, 206.0, 196.0, 197.0, 197.0, 208.0, 208.0, 197.0, 197.0], "ai-astar": [129.0, 126.0, 132.0, 139.0, 140.0, 135.0, 135.0, 132.0, 134.0, 132.0], "imaging-gaussian-blur": [149.0, 142.0, 142.0, 155.0, 146.0, 141.0, 142.0, 148.0, 155.0, 149.0], "audio-beat-detection": [191.0, 168.0, 192.0, 207.0, 164.0, 187.0, 179.0, 155.0, 207.0, 165.0], "json-stringify-tinderbox": [80.0, 82.0, 85.0, 83.0, 85.0, 85.0, 84.0, 88.0, 88.0, 88.0], "stanford-crypto-pbkdf2": [182.0, 188.0, 202.0, 187.0, 185.0, 183.0, 185.0, 182.0, 188.0, 187.0], "json-parse-financial": [64.0, 68.0, 69.0, 73.0, 70.0, 72.0, 71.0, 80.0, 74.0, 72.0], "stanford-crypto-sha256-iterative": [80.0, 85.0, 86.0, 87.0, 87.0, 91.0, 90.0, 90.0, 91.0, 86.0], "audio-fft": [86.0, 102.0, 109.0, 108.0, 87.0, 89.0, 90.0, 102.0, 107.0, 81.0], "imaging-darkroom": [154.0, 162.0, 159.0, 154.0, 154.0, 154.0, 163.0, 161.0, 154.0, 154.0], "stanford-crypto-ccm": [167.0, 167.0, 165.0, 159.0, 166.0, 159.0, 157.0, 161.0, 154.0, 156.0], "audio-oscillator": [118.0, 121.0, 168.0, 114.0, 115.0, 113.0, 158.0, 109.0, 110.0, 162.0], "stanford-crypto-aes": [103.0, 108.0, 111.0, 111.0, 109.0, 113.0, 109.0, 105.0, 106.0, 107.0], "imaging-desaturate": [125.0, 130.0, 129.0, 136.0, 136.0, 129.0, 130.0, 130.0, 127.0, 123.0]}, "summary": {"suite": 1873.8999999999999, "subtests": {"audio-fft": {"filtered": 96.1, "value": 96.1}, "stanford-crypto-pbkdf2": {"filtered": 186.9, "value": 186.9}, "audio-beat-detection": {"filtered": 181.5, "value": 181.5}, "stanford-crypto-ccm": {"filtered": 161.1, "value": 161.1}, "imaging-darkroom": {"filtered": 156.9, "value": 156.9}, "json-parse-financial": {"filtered": 71.3, "value": 71.3}, "audio-oscillator": {"filtered": 128.8, "value": 128.8}, "ai-astar": {"filtered": 133.4, "value": 133.4}, "audio-dft": {"filtered": 201.2, "value": 201.2}, "stanford-crypto-sha256-iterative": {"filtered": 87.3, "value": 87.3}, "json-stringify-tinderbox": {"filtered": 84.8, "value": 84.8}, "imaging-gaussian-blur": {"filtered": 146.9, "value": 146.9}, "stanford-crypto-aes": {"filtered": 108.2, "value": 108.2}, "imaging-desaturate": {"filtered": 129.5, "value": 129.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1446494483, "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": "20151102103507", "branch": "Mozilla-Inbound", "revision": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [246.9745616201531], "Encrypt": [390.32006245121], "NavierStokes": [7084.507042253521], "Decrypt": [7120.567375886525], "Splay": [831.9536423841059], "Richards": [201.4098690835851], "RegExp": [36745.454545454544], "Earley": [982.3182711198428], "Boyer": [16241.935483870968], "RayTrace": [2551.0204081632655]}, "summary": {"suite": 14841.205574078396, "subtests": {"DeltaBlue": {"filtered": 267.7117819999999, "value": 267.7117819999999}, "Encrypt": {"filtered": 681.9557220000002, "value": 681.9557220000002}, "NavierStokes": {"filtered": 209.47117296222666, "value": 209.47117296222666}, "Decrypt": {"filtered": 37.381993027888434, "value": 37.381993027888434}, "Splay": {"filtered": 97.95137114427858, "value": 97.95137114427858}, "RegExp": {"filtered": 24.791773874319663, "value": 24.791773874319663}, "Richards": {"filtered": 175.27443, "value": 175.27443}, "Earley": {"filtered": 678.4593339999998, "value": 678.4593339999998}, "Boyer": {"filtered": 41.033471698113175, "value": 41.033471698113175}, "RayTrace": {"filtered": 290.07568799999996, "value": 290.07568799999996}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1446494483, "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": "20151102103507", "branch": "Mozilla-Inbound", "revision": "f8b520ee98535e9bfbe4a5dae90fc108e5628f6e"}}] 12:21:43 INFO - RETURN: dromaeo_css: 5644.81 12:21:43 INFO - RETURN: kraken: 1873.90 12:21:43 INFO - RETURN: v8_7: 14841.21 12:21:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "14841.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1873.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5644.81"}}} 12:21:43 INFO - Return code: 0 12:21:43 INFO - # TBPL SUCCESS # 12:21:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:21:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:21:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:21:43 INFO - 2015-11-02 12:21:43.496 screenresolution[2580:22199] starting screenresolution argv=screenresolution get 12:21:43 INFO - 2015-11-02 12:21:43.500 screenresolution[2580:22199] Display 0: 1600x1200x32@60 12:21:43 INFO - 2015-11-02 12:21:43.507 screenresolution[2581:22202] starting screenresolution argv=screenresolution list 12:21:43 INFO - Available Modes on Display 0 12:21:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:21:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:21:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:21:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:21:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:21:43 INFO - Intel HD Graphics 3000: 12:21:43 INFO - Chipset Model: Intel HD Graphics 3000 12:21:43 INFO - Type: GPU 12:21:43 INFO - Bus: Built-In 12:21:43 INFO - VRAM (Total): 512 MB 12:21:43 INFO - VRAM (Dynamic, Max): 10 12:21:43 INFO - Vendor: Intel (0x8086) 12:21:43 INFO - Device ID: 0x0116 12:21:43 INFO - Revision ID: 0x0009 12:21:43 INFO - Displays: 12:21:43 INFO - Display: 12:21:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:21:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:21:43 INFO - Display Serial Number: 1600x1200 60 12:21:43 INFO - Main Display: Yes 12:21:43 INFO - Mirror: Off 12:21:43 INFO - Online: Yes 12:21:43 INFO - Rotation: Supported 12:21:43 INFO - Return code: 0 12:21:43 INFO - Running post-action listener: _resource_record_post_action 12:21:43 INFO - Running post-run listener: _resource_record_post_run 12:21:44 INFO - Total resource usage - Wall time: 1264s; CPU: 30.0%; Read bytes: 335872; Write bytes: 684002304; Read time: 80; Write time: 55588 12:21:44 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 334180864; Write bytes: 333871104; Read time: 37889; Write time: 4400 12:21:44 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 335872; Write bytes: 339772416; Read time: 80; Write time: 50484 12:21:44 INFO - Running post-run listener: _upload_blobber_files 12:21:44 INFO - Blob upload gear active. 12:21:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:21:44 INFO - Copying logs to upload dir... 12:21:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1339.387283 ========= master_lag: 2.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-02 12:21:47.528267) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 12:21:47.536713) ========= 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.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010725 build_url: 'https://queue.taskcluster.net/v1/task/vLLJ_Sm-QfuVyjEKoycYfw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 12:21:47.584410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 12:21:47.584885) ========= 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.pm06oPxE2n/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.N1JpPNCScz/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.005806 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 12:21:47.641368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 12:21:47.641737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 12:21:47.648347) ========= ========= Total master_lag: 2.83 =========