builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0079 starttime: 1447324284.83 results: success (0) buildid: 20151112004057 builduid: 2347561f012b430d8c211167c25fc238 revision: 70132ea00d708cd89e146bd8202beba2636f8a41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:24.831926) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:24.832556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:24.832945) ========= 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.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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.005915 basedir: '/builds/slave/test' ========= master_lag: 0.35 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.186038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.186449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.222956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.223378) ========= 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.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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.018009 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.422543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.422904) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.423386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.423834) ========= 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.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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-12 02:31:25-- 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% 23.7M=0s 2015-11-12 02:31:25 (23.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.626343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.626766) ========= 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.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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.183894 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.828364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:25.828934) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70132ea00d708cd89e146bd8202beba2636f8a41 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70132ea00d708cd89e146bd8202beba2636f8a41 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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-12 02:31:25,920 truncating revision to first 12 chars 2015-11-12 02:31:25,920 Setting DEBUG logging. 2015-11-12 02:31:25,920 attempt 1/10 2015-11-12 02:31:25,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/70132ea00d70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 02:31:26,491 unpacking tar archive at: mozilla-aurora-70132ea00d70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846627 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:26.694715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:26.695098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:26.712372) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:26.712717) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 02:31:26.713239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2015-11-12 02:31:26.713614) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:31:27 INFO - MultiFileLogger online at 20151112 02:31:27 in /builds/slave/test 02:31:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:31:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:27 INFO - {'append_to_log': False, 02:31:27 INFO - 'base_work_dir': '/builds/slave/test', 02:31:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:31:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:27 INFO - 'branch': 'Mozilla-Aurora', 02:31:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:27 INFO - 'config_files': ('talos/mac_config.py',), 02:31:27 INFO - 'default_actions': ('clobber', 02:31:27 INFO - 'read-buildbot-config', 02:31:27 INFO - 'download-and-extract', 02:31:27 INFO - 'populate-webroot', 02:31:27 INFO - 'create-virtualenv', 02:31:27 INFO - 'install', 02:31:27 INFO - 'run-tests'), 02:31:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:27 INFO - 'download_minidump_stackwalk': True, 02:31:27 INFO - 'download_symbols': 'ondemand', 02:31:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:27 INFO - 'installer_path': 'installer.exe', 02:31:27 INFO - 'log_level': 'info', 02:31:27 INFO - 'log_name': 'talos', 02:31:27 INFO - 'log_to_console': True, 02:31:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:31:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:31:27 INFO - 'opt_config_files': (), 02:31:27 INFO - 'pip_index': False, 02:31:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:31:27 INFO - 'cmd': ('bash', 02:31:27 INFO - '-c', 02:31:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:31:27 INFO - 'enabled': True, 02:31:27 INFO - 'halt_on_failure': False, 02:31:27 INFO - 'name': 'check_screen_resolution'},), 02:31:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:31:27 INFO - 'cmd': ('bash', 02:31:27 INFO - '-c', 02:31:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:31:27 INFO - 'enabled': True, 02:31:27 INFO - 'halt_on_failure': False, 02:31:27 INFO - 'name': 'check_screen_resolution'},), 02:31:27 INFO - 'run_cmd_checks_enabled': True, 02:31:27 INFO - 'sps_profile': False, 02:31:27 INFO - 'sps_profile_interval': 0, 02:31:27 INFO - 'suite': 'dromaeojs', 02:31:27 INFO - 'system_bits': '64', 02:31:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:27 INFO - 'title': 't-yosemite-r5-0079', 02:31:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:27 INFO - 'use_talos_json': True, 02:31:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:27 INFO - 'work_dir': 'build'} 02:31:27 INFO - ##### 02:31:27 INFO - ##### Running clobber step. 02:31:27 INFO - ##### 02:31:27 INFO - Running pre-action listener: _resource_record_pre_action 02:31:27 INFO - Running main action method: clobber 02:31:27 INFO - rmtree: /builds/slave/test/build 02:31:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:31 INFO - Running post-action listener: _resource_record_post_action 02:31:31 INFO - ##### 02:31:31 INFO - ##### Running read-buildbot-config step. 02:31:31 INFO - ##### 02:31:31 INFO - Running pre-action listener: _resource_record_pre_action 02:31:31 INFO - Running main action method: read_buildbot_config 02:31:31 INFO - Using buildbot properties: 02:31:31 INFO - { 02:31:31 INFO - "properties": { 02:31:31 INFO - "buildnumber": 418, 02:31:31 INFO - "product": "firefox", 02:31:31 INFO - "script_repo_revision": "production", 02:31:31 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:31:31 INFO - "repository": "", 02:31:31 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:31:31 INFO - "buildid": "20151112004057", 02:31:31 INFO - "slavename": "t-yosemite-r5-0079", 02:31:31 INFO - "stage_platform": "macosx64", 02:31:31 INFO - "basedir": "/builds/slave/test", 02:31:31 INFO - "nightly_build": "True", 02:31:31 INFO - "project": "", 02:31:31 INFO - "platform": "yosemite", 02:31:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:31:31 INFO - "slavebuilddir": "test", 02:31:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:31:31 INFO - "branch": "mozilla-aurora", 02:31:31 INFO - "repo_path": "releases/mozilla-aurora", 02:31:31 INFO - "pgo_build": "False", 02:31:31 INFO - "builduid": "2347561f012b430d8c211167c25fc238", 02:31:31 INFO - "revision": "70132ea00d708cd89e146bd8202beba2636f8a41" 02:31:31 INFO - }, 02:31:31 INFO - "sourcestamp": { 02:31:31 INFO - "repository": "", 02:31:31 INFO - "hasPatch": false, 02:31:31 INFO - "project": "", 02:31:31 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:31:31 INFO - "changes": [ 02:31:31 INFO - { 02:31:31 INFO - "category": null, 02:31:31 INFO - "files": [ 02:31:31 INFO - { 02:31:31 INFO - "url": null, 02:31:31 INFO - "name": "https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:31:31 INFO - } 02:31:31 INFO - ], 02:31:31 INFO - "repository": "", 02:31:31 INFO - "rev": "70132ea00d708cd89e146bd8202beba2636f8a41", 02:31:31 INFO - "who": "sendchange", 02:31:31 INFO - "when": 1447324264, 02:31:31 INFO - "number": 6652778, 02:31:31 INFO - "comments": "", 02:31:31 INFO - "project": "", 02:31:31 INFO - "at": "Thu 12 Nov 2015 02:31:04", 02:31:31 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:31:31 INFO - "revlink": "", 02:31:31 INFO - "properties": [ 02:31:31 INFO - [ 02:31:31 INFO - "buildid", 02:31:31 INFO - "20151112004057", 02:31:31 INFO - "Change" 02:31:31 INFO - ], 02:31:31 INFO - [ 02:31:31 INFO - "builduid", 02:31:31 INFO - "2347561f012b430d8c211167c25fc238", 02:31:31 INFO - "Change" 02:31:31 INFO - ], 02:31:31 INFO - [ 02:31:31 INFO - "nightly_build", 02:31:31 INFO - "True", 02:31:32 INFO - "Change" 02:31:32 INFO - ], 02:31:32 INFO - [ 02:31:32 INFO - "pgo_build", 02:31:32 INFO - "False", 02:31:32 INFO - "Change" 02:31:32 INFO - ] 02:31:32 INFO - ], 02:31:32 INFO - "revision": "70132ea00d708cd89e146bd8202beba2636f8a41" 02:31:32 INFO - } 02:31:32 INFO - ], 02:31:32 INFO - "revision": "70132ea00d708cd89e146bd8202beba2636f8a41" 02:31:32 INFO - } 02:31:32 INFO - } 02:31:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:31:32 INFO - Running post-action listener: _resource_record_post_action 02:31:32 INFO - ##### 02:31:32 INFO - ##### Running download-and-extract step. 02:31:32 INFO - ##### 02:31:32 INFO - Running pre-action listener: _resource_record_pre_action 02:31:32 INFO - Running main action method: download_and_extract 02:31:32 INFO - mkdir: /builds/slave/test/build/tests 02:31: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')]} 02:31:32 INFO - https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json 02:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json 02:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:32:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json: timed out 02:32:02 INFO - retry: attempt #1 caught exception: timed out 02:32:02 INFO - retry: Failed, sleeping 30 seconds before retrying 02:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 02:32:33 INFO - Downloaded 1149 bytes. 02:32:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:32:33 INFO - Using the following test package requirements: 02:32:33 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:32:33 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:32:33 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'jsshell-mac.zip'], 02:32:33 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:32:33 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:32:33 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:32:33 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:32:33 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:32:33 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:32:33 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:33 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:32:33 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:33 INFO - https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:32:34 INFO - Downloaded 17447708 bytes. 02:32:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:32:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:32:39 INFO - Return code: 0 02:32:39 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:39 INFO - https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:32:40 INFO - Downloaded 17447708 bytes. 02:32:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:32:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:32:46 INFO - Return code: 0 02:32:46 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')]} 02:32:46 INFO - https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:32:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:32:47 INFO - Downloaded 11131307 bytes. 02:32:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:32:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:32:47 INFO - Return code: 0 02:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:47 INFO - https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:32:52 INFO - Downloaded 107788052 bytes. 02:32:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:52 INFO - mkdir: /builds/slave/test/properties 02:32:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:52 INFO - Contents: 02:32:52 INFO - build_url:https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:52 INFO - Running post-action listener: _resource_record_post_action 02:32:52 INFO - Running post-action listener: set_extra_try_arguments 02:32:52 INFO - ##### 02:32:52 INFO - ##### Running populate-webroot step. 02:32:52 INFO - ##### 02:32:52 INFO - Running pre-action listener: _resource_record_pre_action 02:32:52 INFO - Running main action method: populate_webroot 02:32:52 INFO - Guessing talos json url... 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:32:52 INFO - Downloaded 107 bytes. 02:32:52 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:32:52 INFO - Contents: 02:32:52 INFO - 20151112004057 02:32:52 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/70132ea00d708cd89e146bd8202beba2636f8a41 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/70132ea00d/testing/talos/talos.json 02:32:52 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/70132ea00d/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/70132ea00d/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:32:53 INFO - Downloaded 4264 bytes. 02:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:32:53 INFO - '../fennec_ids.txt'], 02:32:53 INFO - 'tests': ['tcheck2']}, 02:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:53 INFO - '--tppagecycles', 02:32:53 INFO - '7'], 02:32:53 INFO - 'tests': ['tsvgm']}}, 02:32:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:32:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:32:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'tests': ['damp', 'tps']}, 02:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['damp', 'tps']}, 02:32:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:53 INFO - 'other': {'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other_l64': {'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other_nol64': {'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'svgr': {'tests': ['tsvgx', 02:32:53 INFO - 'tsvgr_opacity', 02:32:53 INFO - 'tart', 02:32:53 INFO - 'tscrollx', 02:32:53 INFO - 'cart']}, 02:32:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tsvgx', 02:32:53 INFO - 'tsvgr_opacity', 02:32:53 INFO - 'tart', 02:32:53 INFO - 'tscrollx', 02:32:53 INFO - 'cart']}, 02:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'tests': ['tp5o']}, 02:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tp5o']}, 02:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--xperf_path', 02:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:53 INFO - 'tests': ['tp5n']}, 02:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s', 02:32:53 INFO - '--xperf_path', 02:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:32:53 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:32:53 INFO - 'tests': ['tp5n']}}, 02:32:53 INFO - 'talos.zip': {'path': '', 02:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:53 INFO - Running post-action listener: _resource_record_post_action 02:32:53 INFO - ##### 02:32:53 INFO - ##### Running create-virtualenv step. 02:32:53 INFO - ##### 02:32:53 INFO - Running pre-action listener: _resource_record_pre_action 02:32:53 INFO - Running main action method: create_virtualenv 02:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:53 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 02:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:53 INFO - Using real prefix '/tools/python27' 02:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:58 INFO - Installing pip.................done. 02:32:58 INFO - Return code: 0 02:32:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:58 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:32:58 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 02:32:58 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 02:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:58 INFO - 'HOME': '/Users/cltbld', 02:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:58 INFO - 'LOGNAME': 'cltbld', 02:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:58 INFO - 'MOZ_NO_REMOTE': '1', 02:32:58 INFO - 'NO_EM_RESTART': '1', 02:32:58 INFO - 'PAGER': '/bin/cat', 02:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:58 INFO - 'PWD': '/builds/slave/test', 02:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:58 INFO - 'SHELL': '/bin/bash', 02:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:32:58 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:58 INFO - 'USER': 'cltbld', 02:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:58 INFO - 'XPC_FLAGS': '0x0', 02:32:58 INFO - 'XPC_SERVICE_NAME': '0', 02:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:59 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 02:32:59 INFO - Cleaning up... 02:32:59 INFO - Return code: 0 02:32:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:32:59 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')]} 02:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:59 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')]} 02:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:59 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:32:59 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 02:32:59 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 02:32:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:32:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:59 INFO - 'HOME': '/Users/cltbld', 02:32:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:59 INFO - 'LOGNAME': 'cltbld', 02:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:59 INFO - 'MOZ_NO_REMOTE': '1', 02:32:59 INFO - 'NO_EM_RESTART': '1', 02:32:59 INFO - 'PAGER': '/bin/cat', 02:32:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:59 INFO - 'PWD': '/builds/slave/test', 02:32:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:59 INFO - 'SHELL': '/bin/bash', 02:32:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:32:59 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:32:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:59 INFO - 'USER': 'cltbld', 02:32:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:59 INFO - 'XPC_FLAGS': '0x0', 02:32:59 INFO - 'XPC_SERVICE_NAME': '0', 02:32:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:59 INFO - Downloading/unpacking psutil>=0.7.1 02:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:33:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:02 INFO - Installing collected packages: psutil 02:33:02 INFO - Running setup.py install for psutil 02:33:02 INFO - building 'psutil._psutil_osx' extension 02:33:02 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 INFO - building 'psutil._psutil_posix' extension 02:33:04 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 02:33:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:33:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:33:04 INFO - ^ 02:33:04 INFO - 1 warning generated. 02:33:04 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 02:33:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:05 INFO - Successfully installed psutil 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:33:05 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 02:33:05 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 02:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:05 INFO - 'HOME': '/Users/cltbld', 02:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PAGER': '/bin/cat', 02:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:33:05 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - 'XPC_FLAGS': '0x0', 02:33:05 INFO - 'XPC_SERVICE_NAME': '0', 02:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:33:05 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 02:33:05 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 02:33:05 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 02:33:05 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 02:33:05 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 02:33:05 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 02:33:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:33:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:33:08 INFO - Installing collected packages: mozsystemmonitor 02:33:08 INFO - Running setup.py install for mozsystemmonitor 02:33:08 INFO - Successfully installed mozsystemmonitor 02:33:08 INFO - Cleaning up... 02:33:08 INFO - Return code: 0 02:33:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:08 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:33:08 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 02:33:08 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 02:33:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:33:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:08 INFO - 'HOME': '/Users/cltbld', 02:33:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:08 INFO - 'LOGNAME': 'cltbld', 02:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:08 INFO - 'MOZ_NO_REMOTE': '1', 02:33:08 INFO - 'NO_EM_RESTART': '1', 02:33:08 INFO - 'PAGER': '/bin/cat', 02:33:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:08 INFO - 'PWD': '/builds/slave/test', 02:33:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:08 INFO - 'SHELL': '/bin/bash', 02:33:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:33:08 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:33:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:08 INFO - 'USER': 'cltbld', 02:33:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:08 INFO - 'XPC_FLAGS': '0x0', 02:33:08 INFO - 'XPC_SERVICE_NAME': '0', 02:33:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:11 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 02:33:11 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 02:33:11 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 02:33:11 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 02:33:11 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 02:33:11 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 02:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:12 INFO - Downloading docopt-0.6.1.tar.gz 02:33:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:12 INFO - Running setup.py install for blobuploader 02:33:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:12 INFO - Running setup.py install for requests 02:33:13 INFO - Running setup.py install for docopt 02:33:13 INFO - Successfully installed blobuploader requests docopt 02:33:13 INFO - Cleaning up... 02:33:13 INFO - Return code: 0 02:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:13 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:33:13 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 02:33:13 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 02:33:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:33:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:13 INFO - 'HOME': '/Users/cltbld', 02:33:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:13 INFO - 'LOGNAME': 'cltbld', 02:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:13 INFO - 'MOZ_NO_REMOTE': '1', 02:33:13 INFO - 'NO_EM_RESTART': '1', 02:33:13 INFO - 'PAGER': '/bin/cat', 02:33:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:13 INFO - 'PWD': '/builds/slave/test', 02:33:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:13 INFO - 'SHELL': '/bin/bash', 02:33:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:33:13 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:33:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:13 INFO - 'USER': 'cltbld', 02:33:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:13 INFO - 'XPC_FLAGS': '0x0', 02:33:13 INFO - 'XPC_SERVICE_NAME': '0', 02:33:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-CacYgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-BIecXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-8LvgZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-LZxYbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-hc3Q2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-9NxtlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:14 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-F27fdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-WO_p2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-ruWWSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-RZj8Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-cnDiwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-lcAvv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-MCLkJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:15 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-rHDBg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:16 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-d1BR2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:16 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-GqNWV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:16 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-kmPywE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:16 INFO - Running setup.py install for manifestparser 02:33:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozcrash 02:33:16 INFO - Running setup.py install for mozdebug 02:33:16 INFO - Running setup.py install for mozdevice 02:33:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozfile 02:33:17 INFO - Running setup.py install for mozhttpd 02:33:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozinfo 02:33:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozInstall 02:33:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozleak 02:33:18 INFO - Running setup.py install for mozlog 02:33:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:18 INFO - Running setup.py install for moznetwork 02:33:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:18 INFO - Running setup.py install for mozprocess 02:33:18 INFO - Running setup.py install for mozprofile 02:33:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:18 INFO - Running setup.py install for mozrunner 02:33:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:19 INFO - Running setup.py install for mozscreenshot 02:33:19 INFO - Running setup.py install for moztest 02:33:19 INFO - Running setup.py install for mozversion 02:33:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:19 INFO - Cleaning up... 02:33:19 INFO - Return code: 0 02:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:19 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')]} 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 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')]} 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:33:19 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 02:33:19 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 02:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:19 INFO - 'HOME': '/Users/cltbld', 02:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:19 INFO - 'LOGNAME': 'cltbld', 02:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:19 INFO - 'MOZ_NO_REMOTE': '1', 02:33:19 INFO - 'NO_EM_RESTART': '1', 02:33:19 INFO - 'PAGER': '/bin/cat', 02:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:19 INFO - 'PWD': '/builds/slave/test', 02:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:19 INFO - 'SHELL': '/bin/bash', 02:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:33:19 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:19 INFO - 'USER': 'cltbld', 02:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:19 INFO - 'XPC_FLAGS': '0x0', 02:33:19 INFO - 'XPC_SERVICE_NAME': '0', 02:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:19 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-rlM7G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:20 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-AQXRQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:20 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-HA3UXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:20 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-9mqPaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-_CVlgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:20 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-fegs7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:20 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-uvkWmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 02:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:20 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-4Cb2XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-sULciP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-wxwP0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-raCD2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-bbQeY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-35fo3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-M9kLgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:21 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)) 02:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:21 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-HRiQmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:22 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)) 02:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:22 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-G74x6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:22 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)) 02:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:22 INFO - Running setup.py (path:/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/pip-0azbhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:22 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)) 02:33:22 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)) 02:33:22 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)) 02:33:22 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)) 02:33:22 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:22 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:22 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 02:33:22 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 02:33:22 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 02:33:22 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 02:33:22 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 02:33:22 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 02:33:24 INFO - Downloading blessings-1.5.1.tar.gz 02:33:24 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 02:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:25 INFO - Installing collected packages: blessings 02:33:25 INFO - Running setup.py install for blessings 02:33:25 INFO - Successfully installed blessings 02:33:25 INFO - Cleaning up... 02:33:25 INFO - Return code: 0 02:33:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:25 INFO - Reading from file tmpfile_stdout 02:33:25 INFO - Current package versions: 02:33:25 INFO - blessings == 1.5.1 02:33:25 INFO - blobuploader == 1.2.4 02:33:25 INFO - docopt == 0.6.1 02:33:25 INFO - manifestparser == 1.1 02:33:25 INFO - mozInstall == 1.12 02:33:25 INFO - mozcrash == 0.16 02:33:25 INFO - mozdebug == 0.1 02:33:25 INFO - mozdevice == 0.46 02:33:25 INFO - mozfile == 1.2 02:33:25 INFO - mozhttpd == 0.7 02:33:25 INFO - mozinfo == 0.8 02:33:25 INFO - mozleak == 0.1 02:33:25 INFO - mozlog == 3.0 02:33:25 INFO - moznetwork == 0.27 02:33:25 INFO - mozprocess == 0.22 02:33:25 INFO - mozprofile == 0.27 02:33:25 INFO - mozrunner == 6.11 02:33:25 INFO - mozscreenshot == 0.1 02:33:25 INFO - mozsystemmonitor == 0.0 02:33:25 INFO - moztest == 0.7 02:33:25 INFO - mozversion == 1.4 02:33:25 INFO - psutil == 3.1.1 02:33:25 INFO - requests == 1.2.3 02:33:25 INFO - wsgiref == 0.1.2 02:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:25 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 0x10a34ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9f3c69cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, '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.obdcVdFazp/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.n8rvD26f7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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 02:33:25 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 02:33:25 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 02:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:25 INFO - 'HOME': '/Users/cltbld', 02:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:25 INFO - 'LOGNAME': 'cltbld', 02:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:25 INFO - 'MOZ_NO_REMOTE': '1', 02:33:25 INFO - 'NO_EM_RESTART': '1', 02:33:25 INFO - 'PAGER': '/bin/cat', 02:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:25 INFO - 'PWD': '/builds/slave/test', 02:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:25 INFO - 'SHELL': '/bin/bash', 02:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:33:25 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:25 INFO - 'USER': 'cltbld', 02:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:25 INFO - 'XPC_FLAGS': '0x0', 02:33:25 INFO - 'XPC_SERVICE_NAME': '0', 02:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 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)) 02:33:25 INFO - Cleaning up... 02:33:25 INFO - Return code: 0 02:33:25 INFO - Running post-action listener: _resource_record_post_action 02:33:25 INFO - Running post-action listener: _start_resource_monitoring 02:33:26 INFO - Starting resource monitoring. 02:33:26 INFO - ##### 02:33:26 INFO - ##### Running install step. 02:33:26 INFO - ##### 02:33:26 INFO - Running pre-action listener: _resource_record_pre_action 02:33:26 INFO - Running main action method: install 02:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:26 INFO - Reading from file tmpfile_stdout 02:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:26 INFO - Reading from file tmpfile_stdout 02:33:26 INFO - Output received: 02:33:26 INFO - Usage: mozinstall [options] installer 02:33:26 INFO - Options: 02:33:26 INFO - -h, --help show this help message and exit 02:33:26 INFO - -d DEST, --destination=DEST 02:33:26 INFO - Directory to install application into. [default: 02:33:26 INFO - "/builds/slave/test"] 02:33:26 INFO - --app=APP Application being installed. [default: firefox] 02:33:26 INFO - mkdir: /builds/slave/test/build/application 02:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:34:07 INFO - Reading from file tmpfile_stdout 02:34:07 INFO - Output received: 02:34:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:34:07 INFO - Running post-action listener: _resource_record_post_action 02:34:07 INFO - ##### 02:34:07 INFO - ##### Running run-tests step. 02:34:07 INFO - ##### 02:34:07 INFO - Running pre-action listener: _resource_record_pre_action 02:34:07 INFO - Running main action method: run_tests 02:34:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:07 INFO - 2015-11-12 02:34:07.118 screenresolution[1637:8081] starting screenresolution argv=screenresolution get 02:34:07 INFO - 2015-11-12 02:34:07.121 screenresolution[1637:8081] Display 0: 1600x1200x32@60 02:34:07 INFO - 2015-11-12 02:34:07.129 screenresolution[1638:8083] starting screenresolution argv=screenresolution list 02:34:07 INFO - Available Modes on Display 0 02:34:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:07 INFO - Intel HD Graphics 3000: 02:34:07 INFO - Chipset Model: Intel HD Graphics 3000 02:34:07 INFO - Type: GPU 02:34:07 INFO - Bus: Built-In 02:34:07 INFO - VRAM (Total): 512 MB 02:34:07 INFO - VRAM (Dynamic, Max): 10 02:34:07 INFO - Vendor: Intel (0x8086) 02:34:07 INFO - Device ID: 0x0116 02:34:07 INFO - Revision ID: 0x0009 02:34:07 INFO - Displays: 02:34:07 INFO - Display: 02:34:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:07 INFO - Display Serial Number: 1600x1200 60 02:34:07 INFO - Main Display: Yes 02:34:07 INFO - Mirror: Off 02:34:07 INFO - Online: Yes 02:34:07 INFO - Rotation: Supported 02:34:07 INFO - Return code: 0 02:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:07 INFO - Python 2.7.3 02:34:07 INFO - Return code: 0 02:34:07 INFO - grabbing minidump binary from tooltool 02:34:07 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')]} 02:34:07 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 0x10a3039f0>, '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 0x10a062cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cd990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:07 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 02:34:07 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 02:34:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:07 INFO - Return code: 0 02:34:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0079', '--webServer', 'localhost'] in /builds/slave/test/build 02:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0079 --webServer localhost 02:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obdcVdFazp/Render', 02:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:07 INFO - 'HOME': '/Users/cltbld', 02:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:07 INFO - 'LOGNAME': 'cltbld', 02:34:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:07 INFO - 'MOZ_NO_REMOTE': '1', 02:34:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:07 INFO - 'NO_EM_RESTART': '1', 02:34:07 INFO - 'PAGER': '/bin/cat', 02:34:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:07 INFO - 'PWD': '/builds/slave/test', 02:34:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:07 INFO - 'SHELL': '/bin/bash', 02:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8rvD26f7Q/Listeners', 02:34:07 INFO - 'TMPDIR': '/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/', 02:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:07 INFO - 'USER': 'cltbld', 02:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:07 INFO - 'XPC_FLAGS': '0x0', 02:34:07 INFO - 'XPC_SERVICE_NAME': '0', 02:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:34:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0079', '--webServer', 'localhost'] with output_timeout 3600 02:34:07 INFO - mozversion INFO | application_buildid: 20151112004057 02:34:07 INFO - mozversion INFO | application_changeset: 70132ea00d708cd89e146bd8202beba2636f8a41 02:34:07 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:34:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:07 INFO - mozversion INFO | application_name: Firefox 02:34:07 INFO - mozversion INFO | application_remotingname: firefox-dev 02:34:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:07 INFO - mozversion INFO | application_vendor: Mozilla 02:34:07 INFO - mozversion INFO | application_version: 44.0a2 02:34:07 INFO - mozversion INFO | platform_buildid: 20151112004057 02:34:07 INFO - mozversion INFO | platform_changeset: 70132ea00d708cd89e146bd8202beba2636f8a41 02:34:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:07 INFO - mozversion INFO | platform_version: 44.0a2 02:34:07 INFO - 2015-11-12 02:34:07,852 DEBUG : using testdate: 1447324447 02:34:07 INFO - 2015-11-12 02:34:07,852 DEBUG : actual date: 1447324447 02:34:07 INFO - 2015-11-12 02:34:07,862 INFO : starting webserver on 'localhost:49274' 02:34:07 INFO - 2015-11-12 02:34:07,864 INFO : Starting test suite t-yosemite-r5-0079 02:34:07 INFO - 2015-11-12 02:34:07,864 INFO : Starting test dromaeo_css 02:34:07 INFO - 2015-11-12 02:34:07,864 DEBUG : operating with platform_type : mac_ 02:34:07 INFO - 2015-11-12 02:34:07,865 INFO : Initialising browser for dromaeo_css test... 02:34:07 INFO - 2015-11-12 02:34:07,880 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/tmpFd5qVK/profile http://localhost:49274/getInfo.html 02:34:11 INFO - 2015-11-12 02:34:11,018 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:34:11 INFO - 2015-11-12 02:34:11,018 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:34:11 INFO - 2015-11-12 02:34:11,018 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:34:11 INFO - 2015-11-12 02:34:11,018 DEBUG : BROWSER_OUTPUT: __metrics 02:34:11 INFO - 2015-11-12 02:34:11,035 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:11 INFO - 2015-11-12 02:34:11,767 INFO : Browser initialized. 02:34:11 INFO - 2015-11-12 02:34:11,768 INFO : Running cycle 1/1 for dromaeo_css test... 02:34:11 INFO - 2015-11-12 02:34:11,768 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/tmpFd5qVK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:34:23 INFO - 2015-11-12 02:34:23,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 198565888 02:34:23 INFO - 2015-11-12 02:34:23,785 DEBUG : BROWSER_OUTPUT: 02:35:15 INFO - 2015-11-12 02:35:15,482 DEBUG : BROWSER_OUTPUT: 1447324515480 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] 02:37:25 INFO - 2015-11-12 02:37:25,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 02:37:27 INFO - 2015-11-12 02:37:27,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 294998016 02:37:27 INFO - 2015-11-12 02:37:27,101 DEBUG : BROWSER_OUTPUT: 02:40:29 INFO - 2015-11-12 02:40:29,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 02:40:30 INFO - 2015-11-12 02:40:30,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 342671360 02:40:30 INFO - 2015-11-12 02:40:30,456 DEBUG : BROWSER_OUTPUT: 02:43:32 INFO - 2015-11-12 02:43:32,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 02:43:33 INFO - 2015-11-12 02:43:33,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 307609600 02:43:33 INFO - 2015-11-12 02:43:33,104 DEBUG : BROWSER_OUTPUT: 02:46:35 INFO - 2015-11-12 02:46:35,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 02:46:35 INFO - 2015-11-12 02:46:35,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 298778624 02:46:35 INFO - 2015-11-12 02:46:35,724 DEBUG : BROWSER_OUTPUT: 02:49:38 INFO - 2015-11-12 02:49:38,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 02:49:39 INFO - 2015-11-12 02:49:39,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 299716608 02:49:39 INFO - 2015-11-12 02:49:39,387 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 02:52:42 INFO - 2015-11-12 02:52:42,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 344797184 02:52:42 INFO - 2015-11-12 02:52:42,400 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,401 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:52:42 INFO - 2015-11-12 02:52:42,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:52:42 INFO - 2015-11-12 02:52:42,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:52:42 INFO - 2015-11-12 02:52:42,401 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:52:42 INFO - 2015-11-12 02:52:42,403 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2780.652418447694;2846.3453405716696;2873.4109507550943;2892.623958885346;2908.563715442683;4946.7031978081295;4951.3810773653295;4967.180415231483;4967.776450059747;4979.203327467606;4939.876503087416;4973.52751488608;4986.551210391064;4990.525900039491;5025.572826309759;4420.97789511052;4533.229351010336;4546.47715512717;4595.241785105471;4667.556582124693;4444.599986001259;4450.933236001462;4500.864974050767;4546.727196368229;4559.065391594731;4589.426321709786;4610.631149508032;4624.745638989854;4639.907201855961;4673.345731597579;4228.069824638575;4543.068670922486;4602.631789456836;4611.515790841947;4625.329327247547;4283.7858107094835;4410.07388448423;4410.911781764346;4450.888727781799;4464.977675111636;4802.087603355351;4854.563089321978;4880.365552478191;4901.485344038861;4918.04098200851;4902.166631672624;5185.248139019821;5262.23697563855;5267.262583238311;5333.146696528537;5138.332016837825;5190.636655434121;5205.843824685266;5228.980348831979;5258.237555554461;4916.459189489189;4952.529509696573;4965.950340496621;4995.375578052744;5006.74966251686;5128.538431541179;5366.221897824794;5445.074337362658;5452.700101494376;5466.617336786467;5022.121128802445;5060.392752869606;5074.568661663726;5095.31213286209;5159.019786240602;5243.187305967581;5254.343207099113;5258.474152584711;5272.261883336336;5317.335333083364;4872.098661747588;5158.432572417031;5168.250603662448;5175.663581867167;5213.556847667991;5053.898922021613;5100.311457953203;5162.148245539444;5165.74171291434;5217.478252174828;3943.152222272225;3958.7228893977144;3990.341593637075;4032.9395059074136;4040.7575545467366;3502.3345564342694;3597.1007248187952;3602.7297952653657;3613.602503724588;3632.7093832493338;4751.809927602926;4770.284457331428;4806.4712881583;4873.1959226727195;4962.255661650709;5278.709670968057;5290.259363689087;5328.4671532846405;5365.168398898177;5375.220593014069;4675.742834144155;4863.440704319049;4899.363082799213;4905.264210368473;4936.531029552187;4474;4525.570070843265;4560.657950653648;4565.086982603426;4566.337881007235;5245.449227831099;5282.735863206901;5289.312389389354;5294.020606187868;5319.228711836685;5070.442251352274;5213.582913366846;5222.164453687544;5279.8680032997945;5284.101702710472;5237.816676416307;5255.343082114736;5259.789608415621;5390.19147127934;5411.431799660979;5244.737763111905;5289.920651190312;5317.946820531745;5335.919961200508;5340.893182136413;5088.542031217208;5352.598555108305;5364.544013758874;5368.973155134199;5382.650127741685;4945.530174633404;4992.400911890596;5021.44764075944;5028.195488721787;5048.495150484922;5211.817586384458;5273.419923808455;5281;5287.259783630372;5319.228711836685;4738.123447162286;5147.716875571729;5148.30497882796;5149.742512874266;5151.25306830515;5003.974980125076;5028.245763135413;5034.194528875362;5074.340335756328;5173.3533308336455;5096.337476128079;5101.362329708786;5103.055934652101;5130.794768209379;5152.922706159336 02:52:42 INFO - 2015-11-12 02:52:42,404 DEBUG : BROWSER_OUTPUT: |1;ext.html;493.60264986685723;497.30129168518226;506.2861365474679;506.96451248412603;529.4493726524415;28865.278368040785;29999.400011999747;35920.46119308213;36372.636273637254;36410.635893641054;38795;39423;39423.60576394235;39501.60498395015;39631.801840990825;7506.249375062504;8158.306543943757;8214.753557393258;8322.16778322169;8341.665333546634;7650.73222437212;9700.902990970106;9896.752581185456;9911.702648920544;9967.202623790079;9680.322377433582;9870.21038316933;9871.309008369417;9890.060444257784;9893.060159284893;7678.078630564368;7884.960575197145;9735.17251033663;9862.112409883144;9914.702558923243;9602.135807777264;9684.273679473998;9701.223902087817;9725.173360264385;9806.852897206547;36287;36446;36632.084197895;36716.816415918016;36722.44916326257;2763.8894444222205;2796.4546913351905;2918.2996080940634;2965.3179768653113;3121.9531707024184;25069.749302506923;25121.62317565238;25548;25565.908140715477;25735;2074.8651337663155;2094.476380904774;2108.599366120432;2135.1672847589452;2184.14818220894;251410;251477;252229;254000;255159.72420137966;54376.72811635916;55460.72269638626;58522.7073864628;58901.41098589045;63193;57863.71068144716;58376;58847.41152588505;58913.41086589165;59043.70478147582;15677.529674109795;15780.053196808;16044.598885027734;16092.195390230441;16115.677686446206;12006.459709312927;12029.218100823418;12148.271103733805;12193.878061219451;12223.572174973833;18366.081695915153;18419.815801842076;18422.171002304927;18485.353012644762;18541.629167416577;6853.211880633691;7148.032841772762;7148.177959534616;7174.560649379237;7190.8202294942;760.2017881224692;787.3071696906685;922.916937475617;939.0046550656326;1016.4003238089415;26448.735512644627;26529.734702653113;26634.6004809928;26673.3331666706;26845;850.0988951711206;909.9727008189765;955.7132860141929;985.1872205430549;1085.5549224817787;10705.732356691145;12623.621291361274;13653.249071301174;14138.929305353613;14203.715925681428;345734;350636;351682;356085;356213;51219.743901281;51851.48148518467;53060.816351019064;53737.46262537403;54051.45948540543;1255.5919326219016;1264.7091169030991;1269.1496697212706;1279.411470723459;1290.3032362524132;26524.204273871816;26655.33361665974;27728.445431090862;30088.849555752957;30314.39371212519;40006.59993400029;40896.38655420112;45296.773516132205;46293;46375.76812115918;189596;191148;195120;196326;197661;38710.41934371043;38725.80637096796;39298.2140357197;40122.79938600405;40825.59174408218;41225.587744122175;41285.1742965145;42051.36922946097;42279.36580951227;42496.78751606222;32249.51625725569;33000.33999320048;34229.48655770116;34665.65334346624;34701.652983469845;33715.83142084274;33802.3239535203;34540.481892771124;34587.30825383528;34764.65235347614;34075.48886766651;35415.291694165455;35428.29143417169;35434.46848297226;35442.64557354496;27461;30244.24389390195;30310.944095849467;30593.08220753381;32326.217624857458;22593.435164121027;22639.43401414912;22715;22737.31788046361;22811.88594057019 02:52:42 INFO - 2015-11-12 02:52:42,408 DEBUG : BROWSER_OUTPUT: |2;jquery.html;306.1779123054597;309.58206421331204;313.4342511766262;315.0611178687511;320.0861540302437;13263.668408289797;13743.312834358292;15308.617284567878;15732.921335393306;15906.602334941632;14543.345549450274;16061.116638584874;16841.242144103515;17259.654806903887;17422.82577174228;4133.958660413403;4227.450431443924;4235.216484950279;4243.872683819475;4706.152892479361;3119.937601247974;3179.4753865612147;4194.66442684586;4194.853180138696;5828.18405423239;5900.64596124234;6007.6395416274945;6009.278886533601;6012.158297838306;6059.727312270937;5852.239208902858;6001.06983417571;6001.189839371673;6022;6026.975414179578;5628.155776633497;5738.971305143489;5784.913226301609;5798.971005144947;5802.941970580282;20828.791712082835;22107.226247081435;22602.20892268779;22615.434614134778;22640.43398915024;2034.5015471209501;2071.140476702167;2097.9475513112293;2101.63221436248;2111.9788802111934;12950.87049129506;12966.740665186644;12986.35068246584;13437.193768373929;13470.461181552824;1560.4694403902613;1567.2633862084801;1568.302105563025;1588.3487770014353;1594.9601259968479;52639.47360526384;54150.72924635391;55317;61562.69218653923;65335.67332163356;14960.70078598422;15775.526734197992;15909.840901590836;16026.679466410607;16029.438969636007;22580.774192258195;22807.201747939074;23244.65133023006;23250.186243481734;23282.41793955131;9050.773730656654;9173.082691730773;9183.127602877716;9239.630414783333;9276.582553785096;7846.411519136088;7896.32881205104;7916.1688022757935;7941.880871786928;7965.56189409588;7230.9638451807405;7336;7373.262673732691;7381;7381.594012329266;928.8003079337975;942.830290547708;947.4552132523688;2015.4682441344683;2887.4080813433197;361.8245151101714;371.34828376199596;411.32953286143396;425.729661664845;426.6139144074617;9161.404508706913;10236.385816851012;10448.111910487542;10701.304415212986;10785.56857725698;405.8194103623859;406.3092742338037;408.76291750784475;423.0101562344068;435.6318910520605;5591;5617.775288988395;5636.103736981855;5656.490915817596;5700.572457065654;474165;480111;481710;514240;515518;60264.397356026755;60384.396156037874;60860.69569652124;61738.38261617416;62604.37395625986;409.1693861461238;415.71315792103354;416.5917400947089;419.20560537780733;419.437953142784;9298.581563829508;9303.860442093239;9369.906300936904;9636.22910167171;10037.89962100399;31002;31441.52837707482;31819.854220738023;32064;32824;41039.794801025804;41068.383974241005;42013.15973680448;42053;42621.78689106535;5408.78364865401;5456.863578410572;5602.579806514446;5634.1548767683535;5675.035244008446;10520.316179448311;10611.734706632396;10662.786744264917;10688.839667405151;10715.892841071802;8709.477431354138;9020.729378118667;9235.815283694423;9251.814963700823;9331.533423328941;7307.488475806643;8845.336599754915;8872.556372181494;8958.19376256114;9102.453852768855;9018.458892466473;9149.496777677292;9169.724908252763;9184.173424391836;9291.256699464162;5498.560115190855;5521.751521181637;5536.806211782568;5545.916811247754;5573.944260557505;8764.737057888273;8971.50656713887;9104.499252541174;9108.772280693036;9118.22495087925 02:52:42 INFO - 2015-11-12 02:52:42,409 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1431.8424973252934;1550.3333566566375;1602.9679406411872;1640.8113066997291;1648.4642491190361;6381.234251889774;6516.804495865132;6550.344965503447;6727.495437842157;6749.865002699943;6680.265170831205;6780.49146314026;6856.828579285508;6860.142482189726;6865.656717164146;1978.3768113044416;2006.257684656679;2007.6185524750324;2007.9297224597142;2015.6774916013442;1988.3537850198743;1989.7910719374474;2017.0519855667812;2022.5550378916614;2027.7161197432372;1883.500872268843;1890.5557194059386;1898.2976298769406;1903.514603776035;1908.7804902436258;1981.6730239510464;1986.701994700792;1988.965737816342;1990.0646696052831;1997.8401727861735;1926.3739284732378;1931.652302585534;1945.9902700486548;1947.0070264165377;1959.2261056882594;6192.071189321593;6784.321567843176;6793.048973143764;6819.931800682029;6820.04519367289;3732.981335093334;4083.3466645336603;4140.8136633851245;4143.937840932388;4144.958550414487;2608.5695860183046;2609.8042646801564;2613.9085132020477;2677.6251324814543;2690.959635605448;766.3218052023943;766.7124828189429;773.6479901644739;794.7734895554797;794.793353728029;8965.641374345083;9029.593668284942;9032.77418064547;9033.63865445388;9038.909610903938;3786.8674596388996;3791.2038471921205;3832.137769001952;3841.3469710149343;3848.0572259796527;7968.402369822286;7977.60111994398;7986.281234688906;8026.518408895368;8094.392920530866;4292.828286868553;4294.613484786384;4294.935575966363;4295.52749197588;4301.204277208726;3879.9806000969816;3896.473976013202;3902.414637804295;3904.570497245301;3925.568187499373;3116.766242531819;3140.9842950785555;3159.8894038708536;3194.9680503194672;3194.99357702323;1010.2927950434726;1011.5397494140149;1012.1295685710284;1015.0559979219397;1019.5259204469809;1180.1326025371345;1191.666333426642;1200.1598880783486;1212.3756265523264;1215.0583297944163;6414.743410263537;6492.513061520405;6519.608823470607;6529.673516324165;6584.539082264196;400.0379088292661;401.96583290420057;402.40243238790373;404.761190897372;406.97965101744796;4884.3161957326;5080.822171224063;5125.077486052472;5150.613703972217;5201.7399130044105;7343.742968996166;7882;8076.71731489395;8082.110967793538;8093.109757926623;7986.960065199637;8075.636596353178;8080.515169089874;8083.797905052421;8126.187381261827;6319.526035547352;6516.185476815398;6527.804165875032;6570.802875913635;6643.833904152339;6122.632642041313;6126.540509461719;6136.110264011782;6145.539084568586;6266.060090986389;7115.288471152843;7332.853342933218;7336.926630733625;7356.889646655198;7372.48392612512;7385.113786345673;7409.518381305198;7453.366463850633;7485.5508669480005;7504.249575042452;5938.910916336172;6098.054801505774;6099.268087829489;6099.908501372572;6140.692965351804;6634.668266586747;6704.865902682017;6707.463402927657;6724.293949135466;6800.115984922127;5977.701114944149;5998.220231369894;6082.756689732538;6113.938860611515;6155.753769849156;6075.848103797263;6087.4521293083835;6099.542534309856;6151.661658608819;6209.192804935329;6076.787312444043;6213.627182369072;6316.242050953915;6321.33625969285;6325.873482530232;5701.087825947829;5718.771249149988;5730.08318669011;5735.426457354231;5740.655560666373;5720.771169153188;5735.4551317624755;5779.133130030361;5810.4189581041555;5897.734601942837 02:52:42 INFO - 2015-11-12 02:52:42,412 DEBUG : BROWSER_OUTPUT: |4;prototype.html;265.4147604532007;275.01818507926697;277.17402141617987;278.5682192601466;281.3430639456868;5348.759305831237;5426.348838139419;5467.726613669315;5499.560035197184;5516.172574113885;5306.973465132679;5331.760070796814;5384.623076384654;5386.596005299609;5396.676199428037;4041.5352234493043;4079.673626109904;4083.3874918762126;4095.3037983542868;4096.610821971923;3969.741966772165;4027.174429242013;4038.172174704179;4108.322126849066;4120.464339635858;4069.776162311072;4071.9389209161886;4076.4496792932873;4087.9182416351655;4088.6524645405175;4042.43405923171;4058.837646494122;4060.2894493463823;4066.735662181978;4075.9388609170887;3510.4558793387064;3533.8586456541707;3536.2043540203504;3555.6977656898935;3566.4472006838723;5167.173252279617;5230.660007099565;5241.9213711794355;5261.316028916254;5271;4665.906681866378;4674.69614475058;4682.531746825291;4684.695494792862;4712.434507859079;5688.374278829326;5741.33974592923;5742.3396309424115;5755.913661295084;5788.27646544182;3871;3873.69010479161;3876.7092468065007;3879.7866117363815;3893.824777885002;5834.066549352126;5986.2217911671205;5996.760129594811;6044.546659000593;6046.123312119718;3774.9245015099546;3814.2562200371217;3828.3300422425964;3830.1190726133145;3834.118152824866;3861.478700375413;3882.6311500407414;3906.121122747359;3916.138449541096;3922.3528117860806;4570.565796249351;4573.199690054227;4588.472325682523;4590.931136032962;4592.517785632527;5726.971365143231;5740.827775166752;5742.799002034909;5750.9648263312165;5773.364929857712;1391.1305434103685;1442.2716528153217;1447.2835946206694;1453.454954392103;1458;927.972160835176;929.6002718830968;946.8627049077845;954.4845783276953;954.8281309364243;5324.4675532446445;5346.278252435949;5353;5379.435159308295;5379.757910894019;5734.283214598176;5837.620554663933;5889.087191485327;5896.941030589725;5897.76408943646;5339.065663508871;5353.7055461949185;5433.565314774887;5483.369412517612;5501.504864562128;3198.5202219667235;3255.267564797949;3284.080457471912;3288.145082278577;3291.358185153872;5955.493783028404;5960.76156953717;5973.910391344133;6013.368596297413;6015;5823;6003.849903752353;6031.849203769941;6043.3050199227655;6114.144019837227;5967.343592204854;5992.64044157352;5994.70026498682;5997.340292567814;6019.247594050744;5967.791127310524;5988.6706231157705;6009.098635204754;6009.489193418433;6019.54853385989;5755.71221438918;5814.331351894586;5906.143609176559;5913.497352724895;5917.993941030121;5939.406059394026;5946.940530594638;5953.434423729739;5977.760889564369;5992.970035149797;3757.5490941087246;3768.736188466891;3770.2836461072307;3773.358529050123;3774.75464094833;5940.257467816523;5940.61386009908;5943.049112142209;5954.553408494467;5958.582899197015;5700.543956483389;5857.238558987305;5866.50134738552;5874.794382196603;5876.118582212532;5815.389384114607;5856.707164641836;5862.443067908542;5887.028640274307;5887.028640274307;5696.772129114789;5719.914201287067;5727.570432217517;5728.455796699307;5743.368229494668;5687.573431992534;5836.970815145897;5847.093700476433;5857.531397488276;5874.559408044499;5728.455796699307;5745.166950792195;5757.36668966405;5768.971155144198;5779.2198053263955 02:52:42 INFO - 2015-11-12 02:52:42,413 DEBUG : BROWSER_OUTPUT: |5;yui.html;601.1823919469521;627.6108812536228;658.7924803686839;691.7647999680107;699.325151229064;12316.876831231684;12627.810582841264;12672.936635316823;12689.238645681255;12696.174748641331;11566.710832229199;11969;12006.159568830186;12038.458269377878;12044.337561434118;655.672163918041;669.2738378858944;782.1708988472224;811.6388207247777;816.8162163513222;802.7190483330846;809.9878501822477;819.0417211862135;820.8440396324709;821.1337039423406;856.6530555125153;863.7106569299261;864.9005364383082;866.9826603467927;867.5835598912525;684.5242556423287;697.8081027717368;846.191886748154;848.762346542969;856.2636132925679;618.6597371445732;628.1927722876128;636.112622891069;636.4749082007362;640.2349192714707;11878.762424751456;11922.463489143009;11958.88041119595;11969.162158648898;11988.580399685969;9933.850992235122;10402.271840971134;10622.09712174466;10700.839487407695;11143.777124457465;7891.921080789176;7931.484453510561;8130.3902207334095;8148.714794982147;8150.510969341858;2691;2706.9323266918286;2710.097459658086;2734.2207470870903;2738.9178324650093;38097.61902380996;38798.999999999716;44821;45012.77493612544;45078;5961.761529538857;6058.757649694051;6081.27024757032;6093.939060609426;6324.146240257506;10881.782364352668;10989.395583242998;11000.834987475195;11019.338839669485;11038.613648522423;5354.491323324278;5424.213489044067;5512.490943197728;5550.8057217997175;5711.057675483498;3390.2371966307383;3395.864165433404;3411.778234414755;3430.2110514581786;3432.3306955143507;2364.6334818103223;2390.7728765767224;2391.246757271454;2392.8205384596226;2393.341830996455;352.9735269854771;359.77514053716425;360.28123892833963;362.9927401451956;368.87458264190303;503.2300580112434;512.3723438787456;520.9895802083937;524.1063985904025;534.6150771444553;6575;6857.314268573203;7389.261073892568;7458.776236712907;7573.431992600577;416.6500139882513;427.0178589244725;452.984145554904;471.9339292499053;541.2341536725489;2981.9552706709414;3066.601341825593;3288.137617966777;3314.4531152360073;3372.9325413492083;55904.16143757847;56215.43784562102;56234;56402;56977;41760.58239417628;42209;42901.14197716028;47084.7645761769;47269.76365118221;41485.37771933423;42251.57748422476;42425.57574424278;42485.362719559234;42766.57233427688;6812.318768123148;6841.17905851301;6888.41448476885;6978.092847929736;7082.787516374517;30439.695603043685;31238.687613123577;31670.524942126347;31947.201319967186;32592.837035814668;40237;41976.790116049226;42237.78881105575;42280.788596056824;42752.5724742761;6960.164780226405;7090.220075791555;7109.111361079865;7150.96424517874;7195.856082878208;9707.563159657691;9990.450525220891;10128.44293563861;10249;10625.521851516545;9228.676996305097;9379.531023448664;9383.108604682544;9479.38384005065;9576.425414475154;9181.265498760216;9360.765980850534;9385.15533601979;9429.764255893657;9490.240780737386;8768.298536117223;9109.22571581423;9118.361714680173;9148;9159.816803664022;7907;8234.176582341717;8282.751517454486;8378.287845533197;8444.240018398374;7651.579163146081;8132.512049277062;8230.218129277948;8397;8411 02:52:42 INFO - 2015-11-12 02:52:42,413 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:52:42 INFO - 2015-11-12 02:52:42,413 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:52:42 INFO - 2015-11-12 02:52:42,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1021 02:52:42 INFO - 2015-11-12 02:52:42,415 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:52:42 INFO - 2015-11-12 02:52:42,415 DEBUG : BROWSER_OUTPUT: __startTimestamp1447325562400__endTimestamp 02:52:42 INFO - 2015-11-12 02:52:42,415 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,415 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:52:42 INFO - 2015-11-12 02:52:42,416 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:52:42 INFO - 2015-11-12 02:52:42,416 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,416 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4870.35 Median:5025.57 stddev:541.32 (10.8%) stddev-sans-first:517.57 02:52:42 INFO - 2015-11-12 02:52:42,416 DEBUG : BROWSER_OUTPUT: Values: 2780.7 2846.3 2873.4 2892.6 2908.6 4946.7 4951.4 4967.2 4967.8 4979.2 4939.9 4973.5 4986.6 4990.5 5025.6 4421.0 4533.2 4546.5 4595.2 4667.6 4444.6 4450.9 4500.9 4546.7 4559.1 4589.4 4610.6 4624.7 4639.9 4673.3 4228.1 4543.1 4602.6 4611.5 4625.3 4283.8 4410.1 4410.9 4450.9 4465.0 4802.1 4854.6 4880.4 4901.5 4918.0 4902.2 5185.2 5262.2 5267.3 5333.1 5138.3 5190.6 5205.8 5229.0 5258.2 4916.5 4952.5 4966.0 4995.4 5006.7 5128.5 5366.2 5445.1 5452.7 5466.6 5022.1 5060.4 5074.6 5095.3 5159.0 5243.2 5254.3 5258.5 5272.3 5317.3 4872.1 5158.4 5168.3 5175.7 5213.6 5053.9 5100.3 5162.1 5165.7 5217.5 3943.2 3958.7 3990.3 4032.9 4040.8 3502.3 3597.1 3602.7 3613.6 3632.7 4751.8 4770.3 4806.5 4873.2 4962.3 5278.7 5290.3 5328.5 5365.2 5375.2 4675.7 4863.4 4899.4 4905.3 4936.5 4474.0 4525.6 4560.7 4565.1 4566.3 5245.4 5282.7 5289.3 5294.0 5319.2 5070.4 5213.6 5222.2 5279.9 5284.1 5237.8 5255.3 5259.8 5390.2 5411.4 5244.7 5289.9 5317.9 5335.9 5340.9 5088.5 5352.6 5364.5 5369.0 5382.7 4945.5 4992.4 5021.4 5028.2 5048.5 5211.8 5273.4 5281.0 5287.3 5319.2 4738.1 5147.7 5148.3 5149.7 5151.3 5004.0 5028.2 5034.2 5074.3 5173.4 5096.3 5101.4 5103.1 5130.8 5152.9 02:52:42 INFO - 2015-11-12 02:52:42,416 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,417 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43355.71 Median:35438.56 stddev:71941.50 (203.0%) stddev-sans-first:72071.33 02:52:42 INFO - 2015-11-12 02:52:42,418 DEBUG : BROWSER_OUTPUT: Values: 493.6 497.3 506.3 507.0 529.4 28865.3 29999.4 35920.5 36372.6 36410.6 38795.0 39423.0 39423.6 39501.6 39631.8 7506.2 8158.3 8214.8 8322.2 8341.7 7650.7 9700.9 9896.8 9911.7 9967.2 9680.3 9870.2 9871.3 9890.1 9893.1 7678.1 7885.0 9735.2 9862.1 9914.7 9602.1 9684.3 9701.2 9725.2 9806.9 36287.0 36446.0 36632.1 36716.8 36722.4 2763.9 2796.5 2918.3 2965.3 3122.0 25069.7 25121.6 25548.0 25565.9 25735.0 2074.9 2094.5 2108.6 2135.2 2184.1 251410.0 251477.0 252229.0 254000.0 255159.7 54376.7 55460.7 58522.7 58901.4 63193.0 57863.7 58376.0 58847.4 58913.4 59043.7 15677.5 15780.1 16044.6 16092.2 16115.7 12006.5 12029.2 12148.3 12193.9 12223.6 18366.1 18419.8 18422.2 18485.4 18541.6 6853.2 7148.0 7148.2 7174.6 7190.8 760.2 787.3 922.9 939.0 1016.4 26448.7 26529.7 26634.6 26673.3 26845.0 850.1 910.0 955.7 985.2 1085.6 10705.7 12623.6 13653.2 14138.9 14203.7 345734.0 350636.0 351682.0 356085.0 356213.0 51219.7 51851.5 53060.8 53737.5 54051.5 1255.6 1264.7 1269.1 1279.4 1290.3 26524.2 26655.3 27728.4 30088.8 30314.4 40006.6 40896.4 45296.8 46293.0 46375.8 189596.0 191148.0 195120.0 196326.0 197661.0 38710.4 38725.8 39298.2 40122.8 40825.6 41225.6 41285.2 42051.4 42279.4 42496.8 32249.5 33000.3 34229.5 34665.7 34701.7 33715.8 33802.3 34540.5 34587.3 34764.7 34075.5 35415.3 35428.3 35434.5 35442.6 27461.0 30244.2 30310.9 30593.1 32326.2 22593.4 22639.4 22715.0 22737.3 22811.9 02:52:42 INFO - 2015-11-12 02:52:42,418 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,418 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25872.78 Median:239435.58 stddev:80552.60 (33.6%) stddev-sans-first:80755.69 02:52:42 INFO - 2015-11-12 02:52:42,419 DEBUG : BROWSER_OUTPUT: Values: 306.2 309.6 313.4 315.1 320.1 13263.7 13743.3 15308.6 15732.9 15906.6 14543.3 16061.1 16841.2 17259.7 17422.8 4134.0 4227.5 4235.2 4243.9 4706.2 3119.9 3179.5 4194.7 4194.9 5828.2 5900.6 6007.6 6009.3 6012.2 6059.7 5852.2 6001.1 6001.2 6022.0 6027.0 5628.2 5739.0 5784.9 5799.0 5802.9 20828.8 22107.2 22602.2 22615.4 22640.4 2034.5 2071.1 2097.9 2101.6 2112.0 12950.9 12966.7 12986.4 13437.2 13470.5 1560.5 1567.3 1568.3 1588.3 1595.0 52639.5 54150.7 55317.0 61562.7 65335.7 14960.7 15775.5 15909.8 16026.7 16029.4 22580.8 22807.2 23244.7 23250.2 23282.4 9050.8 9173.1 9183.1 9239.6 9276.6 7846.4 7896.3 7916.2 7941.9 7965.6 7231.0 7336.0 7373.3 7381.0 7381.6 928.8 942.8 947.5 2015.5 2887.4 361.8 371.3 411.3 425.7 426.6 9161.4 10236.4 10448.1 10701.3 10785.6 405.8 406.3 408.8 423.0 435.6 5591.0 5617.8 5636.1 5656.5 5700.6 474165.0 480111.0 481710.0 514240.0 515518.0 60264.4 60384.4 60860.7 61738.4 62604.4 409.2 415.7 416.6 419.2 419.4 9298.6 9303.9 9369.9 9636.2 10037.9 31002.0 31441.5 31819.9 32064.0 32824.0 41039.8 41068.4 42013.2 42053.0 42621.8 5408.8 5456.9 5602.6 5634.2 5675.0 10520.3 10611.7 10662.8 10688.8 10715.9 8709.5 9020.7 9235.8 9251.8 9331.5 7307.5 8845.3 8872.6 8958.2 9102.5 9018.5 9149.5 9169.7 9184.2 9291.3 5498.6 5521.8 5536.8 5545.9 5573.9 8764.7 8971.5 9104.5 9108.8 9118.2 02:52:42 INFO - 2015-11-12 02:52:42,419 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,420 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4764.42 Median:5958.31 stddev:2457.93 (41.3%) stddev-sans-first:2452.06 02:52:42 INFO - 2015-11-12 02:52:42,421 DEBUG : BROWSER_OUTPUT: Values: 1431.8 1550.3 1603.0 1640.8 1648.5 6381.2 6516.8 6550.3 6727.5 6749.9 6680.3 6780.5 6856.8 6860.1 6865.7 1978.4 2006.3 2007.6 2007.9 2015.7 1988.4 1989.8 2017.1 2022.6 2027.7 1883.5 1890.6 1898.3 1903.5 1908.8 1981.7 1986.7 1989.0 1990.1 1997.8 1926.4 1931.7 1946.0 1947.0 1959.2 6192.1 6784.3 6793.0 6819.9 6820.0 3733.0 4083.3 4140.8 4143.9 4145.0 2608.6 2609.8 2613.9 2677.6 2691.0 766.3 766.7 773.6 794.8 794.8 8965.6 9029.6 9032.8 9033.6 9038.9 3786.9 3791.2 3832.1 3841.3 3848.1 7968.4 7977.6 7986.3 8026.5 8094.4 4292.8 4294.6 4294.9 4295.5 4301.2 3880.0 3896.5 3902.4 3904.6 3925.6 3116.8 3141.0 3159.9 3195.0 3195.0 1010.3 1011.5 1012.1 1015.1 1019.5 1180.1 1191.7 1200.2 1212.4 1215.1 6414.7 6492.5 6519.6 6529.7 6584.5 400.0 402.0 402.4 404.8 407.0 4884.3 5080.8 5125.1 5150.6 5201.7 7343.7 7882.0 8076.7 8082.1 8093.1 7987.0 8075.6 8080.5 8083.8 8126.2 6319.5 6516.2 6527.8 6570.8 6643.8 6122.6 6126.5 6136.1 6145.5 6266.1 7115.3 7332.9 7336.9 7356.9 7372.5 7385.1 7409.5 7453.4 7485.6 7504.2 5938.9 6098.1 6099.3 6099.9 6140.7 6634.7 6704.9 6707.5 6724.3 6800.1 5977.7 5998.2 6082.8 6113.9 6155.8 6075.8 6087.5 6099.5 6151.7 6209.2 6076.8 6213.6 6316.2 6321.3 6325.9 5701.1 5718.8 5730.1 5735.4 5740.7 5720.8 5735.5 5779.1 5810.4 5897.7 02:52:42 INFO - 2015-11-12 02:52:42,421 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,421 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4757.19 Median:5475.55 stddev:1465.71 (26.8%) stddev-sans-first:1430.52 02:52:42 INFO - 2015-11-12 02:52:42,421 DEBUG : BROWSER_OUTPUT: Values: 265.4 275.0 277.2 278.6 281.3 5348.8 5426.3 5467.7 5499.6 5516.2 5307.0 5331.8 5384.6 5386.6 5396.7 4041.5 4079.7 4083.4 4095.3 4096.6 3969.7 4027.2 4038.2 4108.3 4120.5 4069.8 4071.9 4076.4 4087.9 4088.7 4042.4 4058.8 4060.3 4066.7 4075.9 3510.5 3533.9 3536.2 3555.7 3566.4 5167.2 5230.7 5241.9 5261.3 5271.0 4665.9 4674.7 4682.5 4684.7 4712.4 5688.4 5741.3 5742.3 5755.9 5788.3 3871.0 3873.7 3876.7 3879.8 3893.8 5834.1 5986.2 5996.8 6044.5 6046.1 3774.9 3814.3 3828.3 3830.1 3834.1 3861.5 3882.6 3906.1 3916.1 3922.4 4570.6 4573.2 4588.5 4590.9 4592.5 5727.0 5740.8 5742.8 5751.0 5773.4 1391.1 1442.3 1447.3 1453.5 1458.0 928.0 929.6 946.9 954.5 954.8 5324.5 5346.3 5353.0 5379.4 5379.8 5734.3 5837.6 5889.1 5896.9 5897.8 5339.1 5353.7 5433.6 5483.4 5501.5 3198.5 3255.3 3284.1 3288.1 3291.4 5955.5 5960.8 5973.9 6013.4 6015.0 5823.0 6003.8 6031.8 6043.3 6114.1 5967.3 5992.6 5994.7 5997.3 6019.2 5967.8 5988.7 6009.1 6009.5 6019.5 5755.7 5814.3 5906.1 5913.5 5918.0 5939.4 5946.9 5953.4 5977.8 5993.0 3757.5 3768.7 3770.3 3773.4 3774.8 5940.3 5940.6 5943.0 5954.6 5958.6 5700.5 5857.2 5866.5 5874.8 5876.1 5815.4 5856.7 5862.4 5887.0 5887.0 5696.8 5719.9 5727.6 5728.5 5743.4 5687.6 5837.0 5847.1 5857.5 5874.6 5728.5 5745.2 5757.4 5769.0 5779.2 02:52:42 INFO - 2015-11-12 02:52:42,421 DEBUG : BROWSER_OUTPUT: 02:52:42 INFO - 2015-11-12 02:52:42,423 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11931.66 Median:30727.48 stddev:14811.40 (48.2%) stddev-sans-first:14828.51 02:52:42 INFO - 2015-11-12 02:52:42,424 DEBUG : BROWSER_OUTPUT: Values: 601.2 627.6 658.8 691.8 699.3 12316.9 12627.8 12672.9 12689.2 12696.2 11566.7 11969.0 12006.2 12038.5 12044.3 655.7 669.3 782.2 811.6 816.8 802.7 810.0 819.0 820.8 821.1 856.7 863.7 864.9 867.0 867.6 684.5 697.8 846.2 848.8 856.3 618.7 628.2 636.1 636.5 640.2 11878.8 11922.5 11958.9 11969.2 11988.6 9933.9 10402.3 10622.1 10700.8 11143.8 7891.9 7931.5 8130.4 8148.7 8150.5 2691.0 2706.9 2710.1 2734.2 2738.9 38097.6 38799.0 44821.0 45012.8 45078.0 5961.8 6058.8 6081.3 6093.9 6324.1 10881.8 10989.4 11000.8 11019.3 11038.6 5354.5 5424.2 5512.5 5550.8 5711.1 3390.2 3395.9 3411.8 3430.2 3432.3 2364.6 2390.8 2391.2 2392.8 2393.3 353.0 359.8 360.3 363.0 368.9 503.2 512.4 521.0 524.1 534.6 6575.0 6857.3 7389.3 7458.8 7573.4 416.7 427.0 453.0 471.9 541.2 2982.0 3066.6 3288.1 3314.5 3372.9 55904.2 56215.4 56234.0 56402.0 56977.0 41760.6 42209.0 42901.1 47084.8 47269.8 41485.4 42251.6 42425.6 42485.4 42766.6 6812.3 6841.2 6888.4 6978.1 7082.8 30439.7 31238.7 31670.5 31947.2 32592.8 40237.0 41976.8 42237.8 42280.8 42752.6 6960.2 7090.2 7109.1 7151.0 7195.9 9707.6 9990.5 10128.4 10249.0 10625.5 9228.7 9379.5 9383.1 9479.4 9576.4 9181.3 9360.8 9385.2 9429.8 9490.2 8768.3 9109.2 9118.4 9148.0 9159.8 7907.0 8234.2 8282.8 8378.3 8444.2 7651.6 8132.5 8230.2 8397.0 8411.0 02:52:42 INFO - 2015-11-12 02:52:42,424 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:52:42 INFO - 2015-11-12 02:52:42,424 DEBUG : BROWSER_OUTPUT: 02:52:43 INFO - 2015-11-12 02:52:43,113 INFO : Browser exited with error code: 0 02:52:43 INFO - 2015-11-12 02:52:43,144 INFO : Completed test dromaeo_css (00:18:35) 02:52:43 INFO - 2015-11-12 02:52:43,145 INFO : Starting test kraken 02:52:43 INFO - 2015-11-12 02:52:43,145 DEBUG : operating with platform_type : mac_ 02:52:43 INFO - 2015-11-12 02:52:43,145 INFO : Initialising browser for kraken test... 02:52:43 INFO - 2015-11-12 02:52:43,160 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/tmp4dYtMd/profile http://localhost:49274/getInfo.html 02:52:45 INFO - 2015-11-12 02:52:45,653 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:52:45 INFO - 2015-11-12 02:52:45,653 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:52:45 INFO - 2015-11-12 02:52:45,654 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:52:45 INFO - 2015-11-12 02:52:45,654 DEBUG : BROWSER_OUTPUT: __metrics 02:52:45 INFO - 2015-11-12 02:52:45,669 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:46 INFO - 2015-11-12 02:52:46,408 INFO : Browser initialized. 02:52:46 INFO - 2015-11-12 02:52:46,408 INFO : Running cycle 1/1 for kraken test... 02:52:46 INFO - 2015-11-12 02:52:46,408 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/tmp4dYtMd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:52:58 INFO - 2015-11-12 02:52:58,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 199172096 02:52:58 INFO - 2015-11-12 02:52:58,415 DEBUG : BROWSER_OUTPUT: 02:53:01 INFO - 2015-11-12 02:53:01,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:01 INFO - 2015-11-12 02:53:01,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 264302592 02:53:01 INFO - 2015-11-12 02:53:01,886 DEBUG : BROWSER_OUTPUT: 02:53:04 INFO - 2015-11-12 02:53:04,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 02:53:05 INFO - 2015-11-12 02:53:05,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 276824064 02:53:05 INFO - 2015-11-12 02:53:05,409 DEBUG : BROWSER_OUTPUT: 02:53:08 INFO - 2015-11-12 02:53:08,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 02:53:09 INFO - 2015-11-12 02:53:09,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 264822784 02:53:09 INFO - 2015-11-12 02:53:09,136 DEBUG : BROWSER_OUTPUT: 02:53:11 INFO - 2015-11-12 02:53:11,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 02:53:11 INFO - 2015-11-12 02:53:11,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 267141120 02:53:11 INFO - 2015-11-12 02:53:11,951 DEBUG : BROWSER_OUTPUT: 02:53:14 INFO - 2015-11-12 02:53:14,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:14 INFO - 2015-11-12 02:53:14,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 266563584 02:53:14 INFO - 2015-11-12 02:53:14,931 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-11-12 02:53:18,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:18 INFO - 2015-11-12 02:53:18,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 266928128 02:53:18 INFO - 2015-11-12 02:53:18,937 DEBUG : BROWSER_OUTPUT: 02:53:22 INFO - 2015-11-12 02:53:22,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:23 INFO - 2015-11-12 02:53:23,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 264200192 02:53:23 INFO - 2015-11-12 02:53:23,006 DEBUG : BROWSER_OUTPUT: 02:53:26 INFO - 2015-11-12 02:53:26,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 02:53:26 INFO - 2015-11-12 02:53:26,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 264503296 02:53:26 INFO - 2015-11-12 02:53:26,810 DEBUG : BROWSER_OUTPUT: 02:53:28 INFO - 2015-11-12 02:53:28,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:29 INFO - 2015-11-12 02:53:29,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 297943040 02:53:29 INFO - 2015-11-12 02:53:29,116 DEBUG : BROWSER_OUTPUT: 02:53:31 INFO - 2015-11-12 02:53:31,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:31 INFO - 2015-11-12 02:53:31,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 297566208 02:53:31 INFO - 2015-11-12 02:53:31,727 DEBUG : BROWSER_OUTPUT: 02:53:34 INFO - 2015-11-12 02:53:34,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:34 INFO - 2015-11-12 02:53:34,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 304230400 02:53:34 INFO - 2015-11-12 02:53:34,601 DEBUG : BROWSER_OUTPUT: 02:53:37 INFO - 2015-11-12 02:53:37,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:38 INFO - 2015-11-12 02:53:38,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 307531776 02:53:38 INFO - 2015-11-12 02:53:38,079 DEBUG : BROWSER_OUTPUT: 02:53:40 INFO - 2015-11-12 02:53:40,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:41 INFO - 2015-11-12 02:53:41,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 306909184 02:53:41 INFO - 2015-11-12 02:53:41,483 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 02:53:43 INFO - 2015-11-12 02:53:43,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 366022656 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: |0;ai-astar;119;130;119;128;128;123;110;130;128;119 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;181;152;185;176;147;168;147;184;171;154 02:53:43 INFO - 2015-11-12 02:53:43,627 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;188;189;186;181;181;186;188;187;181 02:53:43 INFO - 2015-11-12 02:53:43,628 DEBUG : BROWSER_OUTPUT: |3;audio-fft;89;85;97;140;79;83;80;80;130;76 02:53:43 INFO - 2015-11-12 02:53:43,628 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;113;154;103;104;104;145;103;101;139 02:53:43 INFO - 2015-11-12 02:53:43,628 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;137;135;142;135;135;130;141;142;141;136 02:53:43 INFO - 2015-11-12 02:53:43,628 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;140;147;146;146;140;146;146 02:53:43 INFO - 2015-11-12 02:53:43,628 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;121;123;118;118;118;118;118;118;119;118 02:53:43 INFO - 2015-11-12 02:53:43,629 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;71;71;73;72;73;73;82;67;67 02:53:43 INFO - 2015-11-12 02:53:43,629 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;73;75;77;76;80;76;79;77;80 02:53:43 INFO - 2015-11-12 02:53:43,629 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;96;97;107;97;96;96;99;99;101 02:53:43 INFO - 2015-11-12 02:53:43,629 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;150;158;153;149;148;152;147;142;150 02:53:43 INFO - 2015-11-12 02:53:43,629 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;158;177;169;169;170;169;169;168;153 02:53:43 INFO - 2015-11-12 02:53:43,629 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;79;84;81;82;80;81;81;81;82 02:53:43 INFO - 2015-11-12 02:53:43,630 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:43 INFO - 2015-11-12 02:53:43,630 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:53:43 INFO - 2015-11-12 02:53:43,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 02:53:43 INFO - 2015-11-12 02:53:43,630 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:53:43 INFO - 2015-11-12 02:53:43,630 DEBUG : BROWSER_OUTPUT: __startTimestamp1447325623624__endTimestamp 02:53:43 INFO - 2015-11-12 02:53:43,630 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,631 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:43 INFO - 2015-11-12 02:53:43,631 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:53:43 INFO - 2015-11-12 02:53:43,631 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,631 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:123.40 Median:128.00 stddev:6.57 (5.1%) stddev-sans-first:6.77 02:53:43 INFO - 2015-11-12 02:53:43,631 DEBUG : BROWSER_OUTPUT: Values: 119.0 130.0 119.0 128.0 128.0 123.0 110.0 130.0 128.0 119.0 02:53:43 INFO - 2015-11-12 02:53:43,632 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,632 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:166.50 Median:173.50 stddev:15.27 (8.8%) stddev-sans-first:15.27 02:53:43 INFO - 2015-11-12 02:53:43,632 DEBUG : BROWSER_OUTPUT: Values: 181.0 152.0 185.0 176.0 147.0 168.0 147.0 184.0 171.0 154.0 02:53:43 INFO - 2015-11-12 02:53:43,632 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,632 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:185.00 Median:186.50 stddev:3.20 (1.7%) stddev-sans-first:3.31 02:53:43 INFO - 2015-11-12 02:53:43,632 DEBUG : BROWSER_OUTPUT: Values: 183.0 188.0 189.0 186.0 181.0 181.0 186.0 188.0 187.0 181.0 02:53:43 INFO - 2015-11-12 02:53:43,633 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,634 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.90 Median:81.50 stddev:22.58 (27.7%) stddev-sans-first:23.88 02:53:43 INFO - 2015-11-12 02:53:43,634 DEBUG : BROWSER_OUTPUT: Values: 89.0 85.0 97.0 140.0 79.0 83.0 80.0 80.0 130.0 76.0 02:53:43 INFO - 2015-11-12 02:53:43,634 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,634 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.70 Median:112.00 stddev:20.19 (18.0%) stddev-sans-first:21.27 02:53:43 INFO - 2015-11-12 02:53:43,634 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 154.0 103.0 104.0 104.0 145.0 103.0 101.0 139.0 02:53:43 INFO - 2015-11-12 02:53:43,635 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,635 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.40 Median:139.00 stddev:3.98 (2.9%) stddev-sans-first:4.22 02:53:43 INFO - 2015-11-12 02:53:43,635 DEBUG : BROWSER_OUTPUT: Values: 137.0 135.0 142.0 135.0 135.0 130.0 141.0 142.0 141.0 136.0 02:53:43 INFO - 2015-11-12 02:53:43,635 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,635 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.90 Median:146.00 stddev:2.60 (1.8%) stddev-sans-first:2.73 02:53:43 INFO - 2015-11-12 02:53:43,635 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 140.0 147.0 146.0 146.0 140.0 146.0 146.0 02:53:43 INFO - 2015-11-12 02:53:43,636 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,636 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:118.90 Median:118.00 stddev:1.73 (1.5%) stddev-sans-first:1.66 02:53:43 INFO - 2015-11-12 02:53:43,636 DEBUG : BROWSER_OUTPUT: Values: 121.0 123.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 02:53:43 INFO - 2015-11-12 02:53:43,636 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,637 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:72.50 stddev:5.24 (7.2%) stddev-sans-first:4.40 02:53:43 INFO - 2015-11-12 02:53:43,637 DEBUG : BROWSER_OUTPUT: Values: 62.0 71.0 71.0 73.0 72.0 73.0 73.0 82.0 67.0 67.0 02:53:43 INFO - 2015-11-12 02:53:43,637 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,637 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:77.00 stddev:3.36 (4.4%) stddev-sans-first:2.35 02:53:43 INFO - 2015-11-12 02:53:43,637 DEBUG : BROWSER_OUTPUT: Values: 69.0 73.0 75.0 77.0 76.0 80.0 76.0 79.0 77.0 80.0 02:53:43 INFO - 2015-11-12 02:53:43,638 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,638 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.10 Median:96.50 stddev:3.81 (4.0%) stddev-sans-first:3.57 02:53:43 INFO - 2015-11-12 02:53:43,638 DEBUG : BROWSER_OUTPUT: Values: 93.0 96.0 97.0 107.0 97.0 96.0 96.0 99.0 99.0 101.0 02:53:43 INFO - 2015-11-12 02:53:43,638 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,638 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:150.00 stddev:4.69 (3.1%) stddev-sans-first:4.40 02:53:43 INFO - 2015-11-12 02:53:43,638 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 158.0 153.0 149.0 148.0 152.0 147.0 142.0 150.0 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:169.00 stddev:6.82 (4.0%) stddev-sans-first:7.10 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: Values: 171.0 158.0 177.0 169.0 169.0 170.0 169.0 169.0 168.0 153.0 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:81.00 stddev:2.91 (3.6%) stddev-sans-first:1.39 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: Values: 73.0 79.0 84.0 81.0 82.0 80.0 81.0 81.0 81.0 82.0 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:43 INFO - 2015-11-12 02:53:43,639 DEBUG : BROWSER_OUTPUT: 02:53:44 INFO - 2015-11-12 02:53:44,359 INFO : Browser exited with error code: 0 02:53:44 INFO - 2015-11-12 02:53:44,413 INFO : Completed test kraken (00:01:01) 02:53:44 INFO - 2015-11-12 02:53:44,413 INFO : Starting test v8_7 02:53:44 INFO - 2015-11-12 02:53:44,413 DEBUG : operating with platform_type : mac_ 02:53:44 INFO - 2015-11-12 02:53:44,413 INFO : Initialising browser for v8_7 test... 02:53:44 INFO - 2015-11-12 02:53:44,427 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/tmpxfyxUT/profile http://localhost:49274/getInfo.html 02:53:46 INFO - 2015-11-12 02:53:46,828 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:53:46 INFO - 2015-11-12 02:53:46,828 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:53:46 INFO - 2015-11-12 02:53:46,828 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:53:46 INFO - 2015-11-12 02:53:46,828 DEBUG : BROWSER_OUTPUT: __metrics 02:53:46 INFO - 2015-11-12 02:53:46,866 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:47 INFO - 2015-11-12 02:53:47,618 INFO : Browser initialized. 02:53:47 INFO - 2015-11-12 02:53:47,619 INFO : Running cycle 1/1 for v8_7 test... 02:53:47 INFO - 2015-11-12 02:53:47,619 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/T/tmpxfyxUT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:53:59 INFO - 2015-11-12 02:53:59,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 199204864 02:53:59 INFO - 2015-11-12 02:53:59,650 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 02:54:22 INFO - 2015-11-12 02:54:22,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 515960832 02:54:22 INFO - 2015-11-12 02:54:22,773 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:54:22 INFO - 2015-11-12 02:54:22,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:54:22 INFO - 2015-11-12 02:54:22,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:54:22 INFO - 2015-11-12 02:54:22,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:54:22 INFO - 2015-11-12 02:54:22,773 DEBUG : BROWSER_OUTPUT: |0;Richards;189.64536317087047 02:54:22 INFO - 2015-11-12 02:54:22,774 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;210.61499578770008 02:54:22 INFO - 2015-11-12 02:54:22,774 DEBUG : BROWSER_OUTPUT: |2;Encrypt;371.19524870081665 02:54:22 INFO - 2015-11-12 02:54:22,774 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7020.979020979021 02:54:22 INFO - 2015-11-12 02:54:22,774 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1194.7431302270013 02:54:22 INFO - 2015-11-12 02:54:22,774 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 02:54:22 INFO - 2015-11-12 02:54:22,774 DEBUG : BROWSER_OUTPUT: |6;Boyer;14371.42857142857 02:54:22 INFO - 2015-11-12 02:54:22,775 DEBUG : BROWSER_OUTPUT: |7;RegExp;33483.333333333336 02:54:22 INFO - 2015-11-12 02:54:22,775 DEBUG : BROWSER_OUTPUT: |8;Splay;671.7914438502673 02:54:22 INFO - 2015-11-12 02:54:22,775 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6718.120805369127 02:54:22 INFO - 2015-11-12 02:54:22,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:54:22 INFO - 2015-11-12 02:54:22,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1447325662772__endTimestamp 02:54:22 INFO - 2015-11-12 02:54:22,775 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,776 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:54:22 INFO - 2015-11-12 02:54:22,777 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:54:22 INFO - 2015-11-12 02:54:22,777 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,777 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.65 Median:189.65 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,777 DEBUG : BROWSER_OUTPUT: Values: 189.6 02:54:22 INFO - 2015-11-12 02:54:22,777 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,777 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:210.61 Median:210.61 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: Values: 210.6 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:371.20 Median:371.20 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: Values: 371.2 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7020.98 Median:7020.98 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: Values: 7021.0 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1194.74 Median:1194.74 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,778 DEBUG : BROWSER_OUTPUT: Values: 1194.7 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: Values: 783.7 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14371.43 Median:14371.43 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: Values: 14371.4 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33483.33 Median:33483.33 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: Values: 33483.3 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:671.79 Median:671.79 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: Values: 671.8 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: 02:54:22 INFO - 2015-11-12 02:54:22,779 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6718.12 Median:6718.12 stddev:0.00 (0.0%) 02:54:22 INFO - 2015-11-12 02:54:22,780 DEBUG : BROWSER_OUTPUT: Values: 6718.1 02:54:22 INFO - 2015-11-12 02:54:22,780 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:54:22 INFO - 2015-11-12 02:54:22,780 DEBUG : BROWSER_OUTPUT: 02:54:23 INFO - 2015-11-12 02:54:23,467 INFO : Browser exited with error code: 0 02:54:23 INFO - 2015-11-12 02:54:23,490 INFO : Completed test v8_7 (00:00:39) 02:54:23 INFO - 2015-11-12 02:54:23,511 INFO : Completed test suite (00:20:15) 02:54:23 INFO - 2015-11-12 02:54:23,512 DEBUG : Working with test: dromaeo_css 02:54:23 INFO - 2015-11-12 02:54:23,512 DEBUG : Generating results file: dromaeo_css 02:54:23 INFO - 2015-11-12 02:54:23,513 DEBUG : Working with test: kraken 02:54:23 INFO - 2015-11-12 02:54:23,513 DEBUG : Generating results file: kraken 02:54:23 INFO - 2015-11-12 02:54:23,513 INFO : javascript benchmark 02:54:23 INFO - 2015-11-12 02:54:23,513 DEBUG : Working with test: v8_7 02:54:23 INFO - 2015-11-12 02:54:23,513 DEBUG : Generating results file: v8_7 02:54:23 INFO - 2015-11-12 02:54:23,513 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:23 INFO - 2015-11-12 02:54:23,568 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:54:23 INFO - 2015-11-12 02:54:23,568 DEBUG : process_Request line: dromaeo_css 6128.02 graph.html#tests=[[72,52,55]] 02:54:23 INFO - 2015-11-12 02:54:23,568 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:23 INFO - 2015-11-12 02:54:23,599 DEBUG : process_Request line: kraken 1730.00 graph.html#tests=[[232,52,55]] 02:54:23 INFO - 2015-11-12 02:54:23,599 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:23 INFO - 2015-11-12 02:54:23,628 DEBUG : process_Request line: v8_7 17678.45 graph.html#tests=[[230,52,55]] 02:54:23 INFO - 2015-11-12 02:54:23,629 INFO : javascript benchmark 02:54:23 INFO - 2015-11-12 02:54:23,631 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [306.1779123054597, 309.58206421331204, 313.4342511766262, 315.0611178687511, 320.0861540302437, 13263.668408289797, 13743.312834358292, 15308.617284567878, 15732.921335393306, 15906.602334941632, 14543.345549450274, 16061.116638584874, 16841.242144103515, 17259.654806903887, 17422.82577174228, 4133.958660413403, 4227.450431443924, 4235.216484950279, 4243.872683819475, 4706.152892479361, 3119.937601247974, 3179.4753865612147, 4194.66442684586, 4194.853180138696, 5828.18405423239, 5900.64596124234, 6007.6395416274945, 6009.278886533601, 6012.158297838306, 6059.727312270937, 5852.239208902858, 6001.06983417571, 6001.189839371673, 6022.0, 6026.975414179578, 5628.155776633497, 5738.971305143489, 5784.913226301609, 5798.971005144947, 5802.941970580282, 20828.791712082835, 22107.226247081435, 22602.20892268779, 22615.434614134778, 22640.43398915024, 2034.5015471209501, 2071.140476702167, 2097.9475513112293, 2101.63221436248, 2111.9788802111934, 12950.87049129506, 12966.740665186644, 12986.35068246584, 13437.193768373929, 13470.461181552824, 1560.4694403902613, 1567.2633862084801, 1568.302105563025, 1588.3487770014353, 1594.9601259968479, 52639.47360526384, 54150.72924635391, 55317.0, 61562.69218653923, 65335.67332163356, 14960.70078598422, 15775.526734197992, 15909.840901590836, 16026.679466410607, 16029.438969636007, 22580.774192258195, 22807.201747939074, 23244.65133023006, 23250.186243481734, 23282.41793955131, 9050.773730656654, 9173.082691730773, 9183.127602877716, 9239.630414783333, 9276.582553785096, 7846.411519136088, 7896.32881205104, 7916.1688022757935, 7941.880871786928, 7965.56189409588, 7230.9638451807405, 7336.0, 7373.262673732691, 7381.0, 7381.594012329266, 928.8003079337975, 942.830290547708, 947.4552132523688, 2015.4682441344683, 2887.4080813433197, 361.8245151101714, 371.34828376199596, 411.32953286143396, 425.729661664845, 426.6139144074617, 9161.404508706913, 10236.385816851012, 10448.111910487542, 10701.304415212986, 10785.56857725698, 405.8194103623859, 406.3092742338037, 408.76291750784475, 423.0101562344068, 435.6318910520605, 5591.0, 5617.775288988395, 5636.103736981855, 5656.490915817596, 5700.572457065654, 474165.0, 480111.0, 481710.0, 514240.0, 515518.0, 60264.397356026755, 60384.396156037874, 60860.69569652124, 61738.38261617416, 62604.37395625986, 409.1693861461238, 415.71315792103354, 416.5917400947089, 419.20560537780733, 419.437953142784, 9298.581563829508, 9303.860442093239, 9369.906300936904, 9636.22910167171, 10037.89962100399, 31002.0, 31441.52837707482, 31819.854220738023, 32064.0, 32824.0, 41039.794801025804, 41068.383974241005, 42013.15973680448, 42053.0, 42621.78689106535, 5408.78364865401, 5456.863578410572, 5602.579806514446, 5634.1548767683535, 5675.035244008446, 10520.316179448311, 10611.734706632396, 10662.786744264917, 10688.839667405151, 10715.892841071802, 8709.477431354138, 9020.729378118667, 9235.815283694423, 9251.814963700823, 9331.533423328941, 7307.488475806643, 8845.336599754915, 8872.556372181494, 8958.19376256114, 9102.453852768855, 9018.458892466473, 9149.496777677292, 9169.724908252763, 9184.173424391836, 9291.256699464162, 5498.560115190855, 5521.751521181637, 5536.806211782568, 5545.916811247754, 5573.944260557505, 8764.737057888273, 8971.50656713887, 9104.499252541174, 9108.772280693036, 9118.22495087925], "dojo.html": [2780.652418447694, 2846.3453405716696, 2873.4109507550943, 2892.623958885346, 2908.563715442683, 4946.7031978081295, 4951.3810773653295, 4967.180415231483, 4967.776450059747, 4979.203327467606, 4939.876503087416, 4973.52751488608, 4986.551210391064, 4990.525900039491, 5025.572826309759, 4420.97789511052, 4533.229351010336, 4546.47715512717, 4595.241785105471, 4667.556582124693, 4444.599986001259, 4450.933236001462, 4500.864974050767, 4546.727196368229, 4559.065391594731, 4589.426321709786, 4610.631149508032, 4624.745638989854, 4639.907201855961, 4673.345731597579, 4228.069824638575, 4543.068670922486, 4602.631789456836, 4611.515790841947, 4625.329327247547, 4283.7858107094835, 4410.07388448423, 4410.911781764346, 4450.888727781799, 4464.977675111636, 4802.087603355351, 4854.563089321978, 4880.365552478191, 4901.485344038861, 4918.04098200851, 4902.166631672624, 5185.248139019821, 5262.23697563855, 5267.262583238311, 5333.146696528537, 5138.332016837825, 5190.636655434121, 5205.843824685266, 5228.980348831979, 5258.237555554461, 4916.459189489189, 4952.529509696573, 4965.950340496621, 4995.375578052744, 5006.74966251686, 5128.538431541179, 5366.221897824794, 5445.074337362658, 5452.700101494376, 5466.617336786467, 5022.121128802445, 5060.392752869606, 5074.568661663726, 5095.31213286209, 5159.019786240602, 5243.187305967581, 5254.343207099113, 5258.474152584711, 5272.261883336336, 5317.335333083364, 4872.098661747588, 5158.432572417031, 5168.250603662448, 5175.663581867167, 5213.556847667991, 5053.898922021613, 5100.311457953203, 5162.148245539444, 5165.74171291434, 5217.478252174828, 3943.152222272225, 3958.7228893977144, 3990.341593637075, 4032.9395059074136, 4040.7575545467366, 3502.3345564342694, 3597.1007248187952, 3602.7297952653657, 3613.602503724588, 3632.7093832493338, 4751.809927602926, 4770.284457331428, 4806.4712881583, 4873.1959226727195, 4962.255661650709, 5278.709670968057, 5290.259363689087, 5328.4671532846405, 5365.168398898177, 5375.220593014069, 4675.742834144155, 4863.440704319049, 4899.363082799213, 4905.264210368473, 4936.531029552187, 4474.0, 4525.570070843265, 4560.657950653648, 4565.086982603426, 4566.337881007235, 5245.449227831099, 5282.735863206901, 5289.312389389354, 5294.020606187868, 5319.228711836685, 5070.442251352274, 5213.582913366846, 5222.164453687544, 5279.8680032997945, 5284.101702710472, 5237.816676416307, 5255.343082114736, 5259.789608415621, 5390.19147127934, 5411.431799660979, 5244.737763111905, 5289.920651190312, 5317.946820531745, 5335.919961200508, 5340.893182136413, 5088.542031217208, 5352.598555108305, 5364.544013758874, 5368.973155134199, 5382.650127741685, 4945.530174633404, 4992.400911890596, 5021.44764075944, 5028.195488721787, 5048.495150484922, 5211.817586384458, 5273.419923808455, 5281.0, 5287.259783630372, 5319.228711836685, 4738.123447162286, 5147.716875571729, 5148.30497882796, 5149.742512874266, 5151.25306830515, 5003.974980125076, 5028.245763135413, 5034.194528875362, 5074.340335756328, 5173.3533308336455, 5096.337476128079, 5101.362329708786, 5103.055934652101, 5130.794768209379, 5152.922706159336], "mootools.html": [1431.8424973252934, 1550.3333566566375, 1602.9679406411872, 1640.8113066997291, 1648.4642491190361, 6381.234251889774, 6516.804495865132, 6550.344965503447, 6727.495437842157, 6749.865002699943, 6680.265170831205, 6780.49146314026, 6856.828579285508, 6860.142482189726, 6865.656717164146, 1978.3768113044416, 2006.257684656679, 2007.6185524750324, 2007.9297224597142, 2015.6774916013442, 1988.3537850198743, 1989.7910719374474, 2017.0519855667812, 2022.5550378916614, 2027.7161197432372, 1883.500872268843, 1890.5557194059386, 1898.2976298769406, 1903.514603776035, 1908.7804902436258, 1981.6730239510464, 1986.701994700792, 1988.965737816342, 1990.0646696052831, 1997.8401727861735, 1926.3739284732378, 1931.652302585534, 1945.9902700486548, 1947.0070264165377, 1959.2261056882594, 6192.071189321593, 6784.321567843176, 6793.048973143764, 6819.931800682029, 6820.04519367289, 3732.981335093334, 4083.3466645336603, 4140.8136633851245, 4143.937840932388, 4144.958550414487, 2608.5695860183046, 2609.8042646801564, 2613.9085132020477, 2677.6251324814543, 2690.959635605448, 766.3218052023943, 766.7124828189429, 773.6479901644739, 794.7734895554797, 794.793353728029, 8965.641374345083, 9029.593668284942, 9032.77418064547, 9033.63865445388, 9038.909610903938, 3786.8674596388996, 3791.2038471921205, 3832.137769001952, 3841.3469710149343, 3848.0572259796527, 7968.402369822286, 7977.60111994398, 7986.281234688906, 8026.518408895368, 8094.392920530866, 4292.828286868553, 4294.613484786384, 4294.935575966363, 4295.52749197588, 4301.204277208726, 3879.9806000969816, 3896.473976013202, 3902.414637804295, 3904.570497245301, 3925.568187499373, 3116.766242531819, 3140.9842950785555, 3159.8894038708536, 3194.9680503194672, 3194.99357702323, 1010.2927950434726, 1011.5397494140149, 1012.1295685710284, 1015.0559979219397, 1019.5259204469809, 1180.1326025371345, 1191.666333426642, 1200.1598880783486, 1212.3756265523264, 1215.0583297944163, 6414.743410263537, 6492.513061520405, 6519.608823470607, 6529.673516324165, 6584.539082264196, 400.0379088292661, 401.96583290420057, 402.40243238790373, 404.761190897372, 406.97965101744796, 4884.3161957326, 5080.822171224063, 5125.077486052472, 5150.613703972217, 5201.7399130044105, 7343.742968996166, 7882.0, 8076.71731489395, 8082.110967793538, 8093.109757926623, 7986.960065199637, 8075.636596353178, 8080.515169089874, 8083.797905052421, 8126.187381261827, 6319.526035547352, 6516.185476815398, 6527.804165875032, 6570.802875913635, 6643.833904152339, 6122.632642041313, 6126.540509461719, 6136.110264011782, 6145.539084568586, 6266.060090986389, 7115.288471152843, 7332.853342933218, 7336.926630733625, 7356.889646655198, 7372.48392612512, 7385.113786345673, 7409.518381305198, 7453.366463850633, 7485.5508669480005, 7504.249575042452, 5938.910916336172, 6098.054801505774, 6099.268087829489, 6099.908501372572, 6140.692965351804, 6634.668266586747, 6704.865902682017, 6707.463402927657, 6724.293949135466, 6800.115984922127, 5977.701114944149, 5998.220231369894, 6082.756689732538, 6113.938860611515, 6155.753769849156, 6075.848103797263, 6087.4521293083835, 6099.542534309856, 6151.661658608819, 6209.192804935329, 6076.787312444043, 6213.627182369072, 6316.242050953915, 6321.33625969285, 6325.873482530232, 5701.087825947829, 5718.771249149988, 5730.08318669011, 5735.426457354231, 5740.655560666373, 5720.771169153188, 5735.4551317624755, 5779.133130030361, 5810.4189581041555, 5897.734601942837], "ext.html": [493.60264986685723, 497.30129168518226, 506.2861365474679, 506.96451248412603, 529.4493726524415, 28865.278368040785, 29999.400011999747, 35920.46119308213, 36372.636273637254, 36410.635893641054, 38795.0, 39423.0, 39423.60576394235, 39501.60498395015, 39631.801840990825, 7506.249375062504, 8158.306543943757, 8214.753557393258, 8322.16778322169, 8341.665333546634, 7650.73222437212, 9700.902990970106, 9896.752581185456, 9911.702648920544, 9967.202623790079, 9680.322377433582, 9870.21038316933, 9871.309008369417, 9890.060444257784, 9893.060159284893, 7678.078630564368, 7884.960575197145, 9735.17251033663, 9862.112409883144, 9914.702558923243, 9602.135807777264, 9684.273679473998, 9701.223902087817, 9725.173360264385, 9806.852897206547, 36287.0, 36446.0, 36632.084197895, 36716.816415918016, 36722.44916326257, 2763.8894444222205, 2796.4546913351905, 2918.2996080940634, 2965.3179768653113, 3121.9531707024184, 25069.749302506923, 25121.62317565238, 25548.0, 25565.908140715477, 25735.0, 2074.8651337663155, 2094.476380904774, 2108.599366120432, 2135.1672847589452, 2184.14818220894, 251410.0, 251477.0, 252229.0, 254000.0, 255159.72420137966, 54376.72811635916, 55460.72269638626, 58522.7073864628, 58901.41098589045, 63193.0, 57863.71068144716, 58376.0, 58847.41152588505, 58913.41086589165, 59043.70478147582, 15677.529674109795, 15780.053196808, 16044.598885027734, 16092.195390230441, 16115.677686446206, 12006.459709312927, 12029.218100823418, 12148.271103733805, 12193.878061219451, 12223.572174973833, 18366.081695915153, 18419.815801842076, 18422.171002304927, 18485.353012644762, 18541.629167416577, 6853.211880633691, 7148.032841772762, 7148.177959534616, 7174.560649379237, 7190.8202294942, 760.2017881224692, 787.3071696906685, 922.916937475617, 939.0046550656326, 1016.4003238089415, 26448.735512644627, 26529.734702653113, 26634.6004809928, 26673.3331666706, 26845.0, 850.0988951711206, 909.9727008189765, 955.7132860141929, 985.1872205430549, 1085.5549224817787, 10705.732356691145, 12623.621291361274, 13653.249071301174, 14138.929305353613, 14203.715925681428, 345734.0, 350636.0, 351682.0, 356085.0, 356213.0, 51219.743901281, 51851.48148518467, 53060.816351019064, 53737.46262537403, 54051.45948540543, 1255.5919326219016, 1264.7091169030991, 1269.1496697212706, 1279.411470723459, 1290.3032362524132, 26524.204273871816, 26655.33361665974, 27728.445431090862, 30088.849555752957, 30314.39371212519, 40006.59993400029, 40896.38655420112, 45296.773516132205, 46293.0, 46375.76812115918, 189596.0, 191148.0, 195120.0, 196326.0, 197661.0, 38710.41934371043, 38725.80637096796, 39298.2140357197, 40122.79938600405, 40825.59174408218, 41225.587744122175, 41285.1742965145, 42051.36922946097, 42279.36580951227, 42496.78751606222, 32249.51625725569, 33000.33999320048, 34229.48655770116, 34665.65334346624, 34701.652983469845, 33715.83142084274, 33802.3239535203, 34540.481892771124, 34587.30825383528, 34764.65235347614, 34075.48886766651, 35415.291694165455, 35428.29143417169, 35434.46848297226, 35442.64557354496, 27461.0, 30244.24389390195, 30310.944095849467, 30593.08220753381, 32326.217624857458, 22593.435164121027, 22639.43401414912, 22715.0, 22737.31788046361, 22811.88594057019], "prototype.html": [265.4147604532007, 275.01818507926697, 277.17402141617987, 278.5682192601466, 281.3430639456868, 5348.759305831237, 5426.348838139419, 5467.726613669315, 5499.560035197184, 5516.172574113885, 5306.973465132679, 5331.760070796814, 5384.623076384654, 5386.596005299609, 5396.676199428037, 4041.5352234493043, 4079.673626109904, 4083.3874918762126, 4095.3037983542868, 4096.610821971923, 3969.741966772165, 4027.174429242013, 4038.172174704179, 4108.322126849066, 4120.464339635858, 4069.776162311072, 4071.9389209161886, 4076.4496792932873, 4087.9182416351655, 4088.6524645405175, 4042.43405923171, 4058.837646494122, 4060.2894493463823, 4066.735662181978, 4075.9388609170887, 3510.4558793387064, 3533.8586456541707, 3536.2043540203504, 3555.6977656898935, 3566.4472006838723, 5167.173252279617, 5230.660007099565, 5241.9213711794355, 5261.316028916254, 5271.0, 4665.906681866378, 4674.69614475058, 4682.531746825291, 4684.695494792862, 4712.434507859079, 5688.374278829326, 5741.33974592923, 5742.3396309424115, 5755.913661295084, 5788.27646544182, 3871.0, 3873.69010479161, 3876.7092468065007, 3879.7866117363815, 3893.824777885002, 5834.066549352126, 5986.2217911671205, 5996.760129594811, 6044.546659000593, 6046.123312119718, 3774.9245015099546, 3814.2562200371217, 3828.3300422425964, 3830.1190726133145, 3834.118152824866, 3861.478700375413, 3882.6311500407414, 3906.121122747359, 3916.138449541096, 3922.3528117860806, 4570.565796249351, 4573.199690054227, 4588.472325682523, 4590.931136032962, 4592.517785632527, 5726.971365143231, 5740.827775166752, 5742.799002034909, 5750.9648263312165, 5773.364929857712, 1391.1305434103685, 1442.2716528153217, 1447.2835946206694, 1453.454954392103, 1458.0, 927.972160835176, 929.6002718830968, 946.8627049077845, 954.4845783276953, 954.8281309364243, 5324.4675532446445, 5346.278252435949, 5353.0, 5379.435159308295, 5379.757910894019, 5734.283214598176, 5837.620554663933, 5889.087191485327, 5896.941030589725, 5897.76408943646, 5339.065663508871, 5353.7055461949185, 5433.565314774887, 5483.369412517612, 5501.504864562128, 3198.5202219667235, 3255.267564797949, 3284.080457471912, 3288.145082278577, 3291.358185153872, 5955.493783028404, 5960.76156953717, 5973.910391344133, 6013.368596297413, 6015.0, 5823.0, 6003.849903752353, 6031.849203769941, 6043.3050199227655, 6114.144019837227, 5967.343592204854, 5992.64044157352, 5994.70026498682, 5997.340292567814, 6019.247594050744, 5967.791127310524, 5988.6706231157705, 6009.098635204754, 6009.489193418433, 6019.54853385989, 5755.71221438918, 5814.331351894586, 5906.143609176559, 5913.497352724895, 5917.993941030121, 5939.406059394026, 5946.940530594638, 5953.434423729739, 5977.760889564369, 5992.970035149797, 3757.5490941087246, 3768.736188466891, 3770.2836461072307, 3773.358529050123, 3774.75464094833, 5940.257467816523, 5940.61386009908, 5943.049112142209, 5954.553408494467, 5958.582899197015, 5700.543956483389, 5857.238558987305, 5866.50134738552, 5874.794382196603, 5876.118582212532, 5815.389384114607, 5856.707164641836, 5862.443067908542, 5887.028640274307, 5887.028640274307, 5696.772129114789, 5719.914201287067, 5727.570432217517, 5728.455796699307, 5743.368229494668, 5687.573431992534, 5836.970815145897, 5847.093700476433, 5857.531397488276, 5874.559408044499, 5728.455796699307, 5745.166950792195, 5757.36668966405, 5768.971155144198, 5779.2198053263955], "yui.html": [601.1823919469521, 627.6108812536228, 658.7924803686839, 691.7647999680107, 699.325151229064, 12316.876831231684, 12627.810582841264, 12672.936635316823, 12689.238645681255, 12696.174748641331, 11566.710832229199, 11969.0, 12006.159568830186, 12038.458269377878, 12044.337561434118, 655.672163918041, 669.2738378858944, 782.1708988472224, 811.6388207247777, 816.8162163513222, 802.7190483330846, 809.9878501822477, 819.0417211862135, 820.8440396324709, 821.1337039423406, 856.6530555125153, 863.7106569299261, 864.9005364383082, 866.9826603467927, 867.5835598912525, 684.5242556423287, 697.8081027717368, 846.191886748154, 848.762346542969, 856.2636132925679, 618.6597371445732, 628.1927722876128, 636.112622891069, 636.4749082007362, 640.2349192714707, 11878.762424751456, 11922.463489143009, 11958.88041119595, 11969.162158648898, 11988.580399685969, 9933.850992235122, 10402.271840971134, 10622.09712174466, 10700.839487407695, 11143.777124457465, 7891.921080789176, 7931.484453510561, 8130.3902207334095, 8148.714794982147, 8150.510969341858, 2691.0, 2706.9323266918286, 2710.097459658086, 2734.2207470870903, 2738.9178324650093, 38097.61902380996, 38798.999999999716, 44821.0, 45012.77493612544, 45078.0, 5961.761529538857, 6058.757649694051, 6081.27024757032, 6093.939060609426, 6324.146240257506, 10881.782364352668, 10989.395583242998, 11000.834987475195, 11019.338839669485, 11038.613648522423, 5354.491323324278, 5424.213489044067, 5512.490943197728, 5550.8057217997175, 5711.057675483498, 3390.2371966307383, 3395.864165433404, 3411.778234414755, 3430.2110514581786, 3432.3306955143507, 2364.6334818103223, 2390.7728765767224, 2391.246757271454, 2392.8205384596226, 2393.341830996455, 352.9735269854771, 359.77514053716425, 360.28123892833963, 362.9927401451956, 368.87458264190303, 503.2300580112434, 512.3723438787456, 520.9895802083937, 524.1063985904025, 534.6150771444553, 6575.0, 6857.314268573203, 7389.261073892568, 7458.776236712907, 7573.431992600577, 416.6500139882513, 427.0178589244725, 452.984145554904, 471.9339292499053, 541.2341536725489, 2981.9552706709414, 3066.601341825593, 3288.137617966777, 3314.4531152360073, 3372.9325413492083, 55904.16143757847, 56215.43784562102, 56234.0, 56402.0, 56977.0, 41760.58239417628, 42209.0, 42901.14197716028, 47084.7645761769, 47269.76365118221, 41485.37771933423, 42251.57748422476, 42425.57574424278, 42485.362719559234, 42766.57233427688, 6812.318768123148, 6841.17905851301, 6888.41448476885, 6978.092847929736, 7082.787516374517, 30439.695603043685, 31238.687613123577, 31670.524942126347, 31947.201319967186, 32592.837035814668, 40237.0, 41976.790116049226, 42237.78881105575, 42280.788596056824, 42752.5724742761, 6960.164780226405, 7090.220075791555, 7109.111361079865, 7150.96424517874, 7195.856082878208, 9707.563159657691, 9990.450525220891, 10128.44293563861, 10249.0, 10625.521851516545, 9228.676996305097, 9379.531023448664, 9383.108604682544, 9479.38384005065, 9576.425414475154, 9181.265498760216, 9360.765980850534, 9385.15533601979, 9429.764255893657, 9490.240780737386, 8768.298536117223, 9109.22571581423, 9118.361714680173, 9148.0, 9159.816803664022, 7907.0, 8234.176582341717, 8282.751517454486, 8378.287845533197, 8444.240018398374, 7651.579163146081, 8132.512049277062, 8230.218129277948, 8397.0, 8411.0]}, "summary": {"suite": 6128.016044845362, "subtests": {"jquery.html": {"filtered": 7345.532020157311, "value": 7345.532020157311}, "dojo.html": {"filtered": 4834.856984489358, "value": 4834.856984489358}, "mootools.html": {"filtered": 3851.296965756036, "value": 3851.296965756036}, "ext.html": {"filtered": 17366.811481002314, "value": 17366.811481002314}, "prototype.html": {"filtered": 4271.12550828672, "value": 4271.12550828672}, "yui.html": {"filtered": 5219.1125529433275, "value": 5219.1125529433275}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0079"}, "testrun": {"date": 1447324447, "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": "44.0a2", "id": "20151112004057", "branch": "Mozilla-Aurora", "revision": "70132ea00d708cd89e146bd8202beba2636f8a41"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 188.0, 189.0, 186.0, 181.0, 181.0, 186.0, 188.0, 187.0, 181.0], "ai-astar": [119.0, 130.0, 119.0, 128.0, 128.0, 123.0, 110.0, 130.0, 128.0, 119.0], "imaging-gaussian-blur": [137.0, 135.0, 142.0, 135.0, 135.0, 130.0, 141.0, 142.0, 141.0, 136.0], "audio-beat-detection": [181.0, 152.0, 185.0, 176.0, 147.0, 168.0, 147.0, 184.0, 171.0, 154.0], "json-stringify-tinderbox": [69.0, 73.0, 75.0, 77.0, 76.0, 80.0, 76.0, 79.0, 77.0, 80.0], "stanford-crypto-pbkdf2": [171.0, 158.0, 177.0, 169.0, 169.0, 170.0, 169.0, 169.0, 168.0, 153.0], "json-parse-financial": [62.0, 71.0, 71.0, 73.0, 72.0, 73.0, 73.0, 82.0, 67.0, 67.0], "stanford-crypto-sha256-iterative": [73.0, 79.0, 84.0, 81.0, 82.0, 80.0, 81.0, 81.0, 81.0, 82.0], "audio-fft": [89.0, 85.0, 97.0, 140.0, 79.0, 83.0, 80.0, 80.0, 130.0, 76.0], "imaging-darkroom": [146.0, 146.0, 146.0, 140.0, 147.0, 146.0, 146.0, 140.0, 146.0, 146.0], "stanford-crypto-ccm": [143.0, 150.0, 158.0, 153.0, 149.0, 148.0, 152.0, 147.0, 142.0, 150.0], "audio-oscillator": [111.0, 113.0, 154.0, 103.0, 104.0, 104.0, 145.0, 103.0, 101.0, 139.0], "stanford-crypto-aes": [93.0, 96.0, 97.0, 107.0, 97.0, 96.0, 96.0, 99.0, 99.0, 101.0], "imaging-desaturate": [121.0, 123.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0]}, "summary": {"suite": 1730.0, "subtests": {"audio-fft": {"filtered": 93.9, "value": 93.9}, "stanford-crypto-pbkdf2": {"filtered": 167.3, "value": 167.3}, "audio-beat-detection": {"filtered": 166.5, "value": 166.5}, "stanford-crypto-ccm": {"filtered": 149.2, "value": 149.2}, "imaging-darkroom": {"filtered": 144.9, "value": 144.9}, "json-parse-financial": {"filtered": 71.1, "value": 71.1}, "audio-oscillator": {"filtered": 117.7, "value": 117.7}, "ai-astar": {"filtered": 123.4, "value": 123.4}, "audio-dft": {"filtered": 185.0, "value": 185.0}, "stanford-crypto-sha256-iterative": {"filtered": 80.4, "value": 80.4}, "json-stringify-tinderbox": {"filtered": 76.2, "value": 76.2}, "imaging-gaussian-blur": {"filtered": 137.4, "value": 137.4}, "stanford-crypto-aes": {"filtered": 98.1, "value": 98.1}, "imaging-desaturate": {"filtered": 118.9, "value": 118.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0079"}, "testrun": {"date": 1447324447, "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": "44.0a2", "id": "20151112004057", "branch": "Mozilla-Aurora", "revision": "70132ea00d708cd89e146bd8202beba2636f8a41"}}, {"talos_counters": {}, "results": {"DeltaBlue": [210.61499578770008], "Encrypt": [371.19524870081665], "NavierStokes": [6718.120805369127], "Decrypt": [7020.979020979021], "Splay": [671.7914438502673], "Richards": [189.64536317087047], "RegExp": [33483.333333333336], "Earley": [783.6990595611285], "Boyer": [14371.42857142857], "RayTrace": [1194.7431302270013]}, "summary": {"suite": 17678.449147337622, "subtests": {"DeltaBlue": {"filtered": 313.92826400000007, "value": 313.92826400000007}, "Encrypt": {"filtered": 717.0916139999997, "value": 717.0916139999997}, "NavierStokes": {"filtered": 220.89510489510505, "value": 220.89510489510505}, "Decrypt": {"filtered": 37.91223406374505, "value": 37.91223406374505}, "Splay": {"filtered": 121.304015920398, "value": 121.304015920398}, "RegExp": {"filtered": 27.207117969138867, "value": 27.207117969138867}, "Richards": {"filtered": 186.14744600000003, "value": 186.14744600000003}, "Earley": {"filtered": 850.4067880000003, "value": 850.4067880000003}, "Boyer": {"filtered": 46.374165009940356, "value": 46.374165009940356}, "RayTrace": {"filtered": 619.3707929999999, "value": 619.3707929999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0079"}, "testrun": {"date": 1447324447, "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": "44.0a2", "id": "20151112004057", "branch": "Mozilla-Aurora", "revision": "70132ea00d708cd89e146bd8202beba2636f8a41"}}] 02:54:23 INFO - RETURN: dromaeo_css: 6128.02 02:54:23 INFO - RETURN: kraken: 1730.00 02:54:23 INFO - RETURN: v8_7: 17678.45 02:54:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17678.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1730.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6128.02"}}} 02:54:23 INFO - Return code: 0 02:54:23 INFO - # TBPL SUCCESS # 02:54:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:23 INFO - 2015-11-12 02:54:23.733 screenresolution[1667:10197] starting screenresolution argv=screenresolution get 02:54:23 INFO - 2015-11-12 02:54:23.738 screenresolution[1667:10197] Display 0: 1600x1200x32@60 02:54:23 INFO - 2015-11-12 02:54:23.745 screenresolution[1668:10201] starting screenresolution argv=screenresolution list 02:54:23 INFO - Available Modes on Display 0 02:54:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:24 INFO - Intel HD Graphics 3000: 02:54:24 INFO - Chipset Model: Intel HD Graphics 3000 02:54:24 INFO - Type: GPU 02:54:24 INFO - Bus: Built-In 02:54:24 INFO - VRAM (Total): 512 MB 02:54:24 INFO - VRAM (Dynamic, Max): 10 02:54:24 INFO - Vendor: Intel (0x8086) 02:54:24 INFO - Device ID: 0x0116 02:54:24 INFO - Revision ID: 0x0009 02:54:24 INFO - Displays: 02:54:24 INFO - Display: 02:54:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:24 INFO - Display Serial Number: 1600x1200 60 02:54:24 INFO - Main Display: Yes 02:54:24 INFO - Mirror: Off 02:54:24 INFO - Online: Yes 02:54:24 INFO - Rotation: Supported 02:54:24 INFO - Return code: 0 02:54:24 INFO - Running post-action listener: _resource_record_post_action 02:54:24 INFO - Running post-run listener: _resource_record_post_run 02:54:25 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 39367680; Write bytes: 688625664; Read time: 4450; Write time: 63625 02:54:25 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 341604864; Write bytes: 346513408; Read time: 36392; Write time: 7912 02:54:25 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 37278720; Write bytes: 340895744; Read time: 3893; Write time: 55696 02:54:25 INFO - Running post-run listener: _upload_blobber_files 02:54:25 INFO - Blob upload gear active. 02:54:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:54:25 INFO - Copying logs to upload dir... 02:54:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1378.441375 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2015-11-12 02:54:25.194379) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 02:54:25.197721) ========= 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.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010955 build_url: 'https://queue.taskcluster.net/v1/task/7P_ucv6oRZGeIqbbml_AQQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 02:54:25.226259) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:54:25.226650) ========= 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.obdcVdFazp/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.n8rvD26f7Q/Listeners TMPDIR=/var/folders/nn/vkzf79jx7119_qmghv_v8z4h00000w/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.005682 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 02:54:25.277298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 02:54:25.277755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 02:54:25.278297) ========= ========= Total master_lag: 0.68 =========