builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0070 starttime: 1446730174.71 results: success (0) buildid: 20151105030433 builduid: e3ee3f5d0cba424fb16469b0b67e9016 revision: 59c648a3f95524cb1ee42f2306c1db2698d35258 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:34.715123) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:34.721203) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-05 05:29:34.721497) ========= 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.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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.005941 basedir: '/builds/slave/test' ========= master_lag: 2.65 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-05 05:29:37.374072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:37.374372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:37.754850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-05 05:29:37.755222) ========= 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.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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.012201 ========= master_lag: 3.81 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-05 05:29:41.575731) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:41.576055) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:41.576439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:41.576727) ========= 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.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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-05 05:29:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-05 05:29:41 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.219170 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:42.028563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:42.032961) ========= 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.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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.044969 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:42.117113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-05 05:29:42.117482) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 59c648a3f95524cb1ee42f2306c1db2698d35258 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 59c648a3f95524cb1ee42f2306c1db2698d35258 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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-05 05:29:42,210 truncating revision to first 12 chars 2015-11-05 05:29:42,210 Setting DEBUG logging. 2015-11-05 05:29:42,210 attempt 1/10 2015-11-05 05:29:42,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/59c648a3f955?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 05:29:43,525 unpacking tar archive at: mozilla-central-59c648a3f955/testing/mozharness/ program finished with exit code 0 elapsedTime=1.574542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-05 05:29:43.712129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:43.712450) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:43.725373) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:43.725728) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 05:29:43.726148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2015-11-05 05:29:43.726482) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:29:43 INFO - MultiFileLogger online at 20151105 05:29:43 in /builds/slave/test 05:29:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:29:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:43 INFO - {'append_to_log': False, 05:29:43 INFO - 'base_work_dir': '/builds/slave/test', 05:29:43 INFO - 'blob_upload_branch': 'Firefox', 05:29:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:43 INFO - 'branch': 'Firefox', 05:29:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:43 INFO - 'config_files': ('talos/mac_config.py',), 05:29:43 INFO - 'default_actions': ('clobber', 05:29:43 INFO - 'read-buildbot-config', 05:29:43 INFO - 'download-and-extract', 05:29:43 INFO - 'populate-webroot', 05:29:43 INFO - 'create-virtualenv', 05:29:43 INFO - 'install', 05:29:43 INFO - 'run-tests'), 05:29:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:43 INFO - 'download_minidump_stackwalk': True, 05:29:43 INFO - 'download_symbols': 'ondemand', 05:29:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:43 INFO - 'installer_path': 'installer.exe', 05:29:43 INFO - 'log_level': 'info', 05:29:43 INFO - 'log_name': 'talos', 05:29:43 INFO - 'log_to_console': True, 05:29:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:43 INFO - 'opt_config_files': (), 05:29:43 INFO - 'pip_index': False, 05:29:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:43 INFO - 'cmd': ('bash', 05:29:43 INFO - '-c', 05:29:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:43 INFO - 'enabled': True, 05:29:43 INFO - 'halt_on_failure': False, 05:29:43 INFO - 'name': 'check_screen_resolution'},), 05:29:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:43 INFO - 'cmd': ('bash', 05:29:44 INFO - '-c', 05:29:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:44 INFO - 'enabled': True, 05:29:44 INFO - 'halt_on_failure': False, 05:29:44 INFO - 'name': 'check_screen_resolution'},), 05:29:44 INFO - 'run_cmd_checks_enabled': True, 05:29:44 INFO - 'sps_profile': False, 05:29:44 INFO - 'sps_profile_interval': 0, 05:29:44 INFO - 'suite': 'dromaeojs', 05:29:44 INFO - 'system_bits': '64', 05:29:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:44 INFO - 'title': 't-yosemite-r5-0070', 05:29:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:44 INFO - 'use_talos_json': True, 05:29:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:44 INFO - 'work_dir': 'build'} 05:29:44 INFO - ##### 05:29:44 INFO - ##### Running clobber step. 05:29:44 INFO - ##### 05:29:44 INFO - Running pre-action listener: _resource_record_pre_action 05:29:44 INFO - Running main action method: clobber 05:29:44 INFO - rmtree: /builds/slave/test/build 05:29:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:47 INFO - Running post-action listener: _resource_record_post_action 05:29:47 INFO - ##### 05:29:47 INFO - ##### Running read-buildbot-config step. 05:29:47 INFO - ##### 05:29:47 INFO - Running pre-action listener: _resource_record_pre_action 05:29:47 INFO - Running main action method: read_buildbot_config 05:29:47 INFO - Using buildbot properties: 05:29:47 INFO - { 05:29:47 INFO - "properties": { 05:29:47 INFO - "buildnumber": 577, 05:29:47 INFO - "product": "firefox", 05:29:47 INFO - "script_repo_revision": "production", 05:29:47 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 05:29:47 INFO - "repository": "", 05:29:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 05:29:47 INFO - "buildid": "20151105030433", 05:29:47 INFO - "slavename": "t-yosemite-r5-0070", 05:29:47 INFO - "stage_platform": "macosx64", 05:29:47 INFO - "basedir": "/builds/slave/test", 05:29:47 INFO - "nightly_build": "True", 05:29:47 INFO - "project": "", 05:29:47 INFO - "platform": "yosemite", 05:29:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:29:47 INFO - "slavebuilddir": "test", 05:29:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:29:47 INFO - "branch": "mozilla-central", 05:29:47 INFO - "repo_path": "mozilla-central", 05:29:47 INFO - "pgo_build": "False", 05:29:47 INFO - "builduid": "e3ee3f5d0cba424fb16469b0b67e9016", 05:29:47 INFO - "revision": "59c648a3f95524cb1ee42f2306c1db2698d35258" 05:29:47 INFO - }, 05:29:47 INFO - "sourcestamp": { 05:29:47 INFO - "repository": "", 05:29:47 INFO - "hasPatch": false, 05:29:47 INFO - "project": "", 05:29:47 INFO - "branch": "mozilla-central-macosx64-talos", 05:29:47 INFO - "changes": [ 05:29:47 INFO - { 05:29:47 INFO - "category": null, 05:29:47 INFO - "files": [ 05:29:47 INFO - { 05:29:47 INFO - "url": null, 05:29:47 INFO - "name": "https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:29:47 INFO - } 05:29:47 INFO - ], 05:29:47 INFO - "repository": "", 05:29:47 INFO - "rev": "59c648a3f95524cb1ee42f2306c1db2698d35258", 05:29:47 INFO - "who": "sendchange", 05:29:47 INFO - "when": 1446730133, 05:29:47 INFO - "number": 6625138, 05:29:47 INFO - "comments": "", 05:29:47 INFO - "project": "", 05:29:47 INFO - "at": "Thu 05 Nov 2015 05:28:53", 05:29:47 INFO - "branch": "mozilla-central-macosx64-talos", 05:29:47 INFO - "revlink": "", 05:29:47 INFO - "properties": [ 05:29:47 INFO - [ 05:29:47 INFO - "buildid", 05:29:47 INFO - "20151105030433", 05:29:47 INFO - "Change" 05:29:47 INFO - ], 05:29:47 INFO - [ 05:29:47 INFO - "builduid", 05:29:47 INFO - "e3ee3f5d0cba424fb16469b0b67e9016", 05:29:47 INFO - "Change" 05:29:47 INFO - ], 05:29:47 INFO - [ 05:29:47 INFO - "nightly_build", 05:29:47 INFO - "True", 05:29:47 INFO - "Change" 05:29:47 INFO - ], 05:29:47 INFO - [ 05:29:47 INFO - "pgo_build", 05:29:47 INFO - "False", 05:29:47 INFO - "Change" 05:29:47 INFO - ] 05:29:47 INFO - ], 05:29:47 INFO - "revision": "59c648a3f95524cb1ee42f2306c1db2698d35258" 05:29:47 INFO - } 05:29:47 INFO - ], 05:29:47 INFO - "revision": "59c648a3f95524cb1ee42f2306c1db2698d35258" 05:29:47 INFO - } 05:29:47 INFO - } 05:29:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:29:47 INFO - Running post-action listener: _resource_record_post_action 05:29:47 INFO - ##### 05:29:47 INFO - ##### Running download-and-extract step. 05:29:47 INFO - ##### 05:29:47 INFO - Running pre-action listener: _resource_record_pre_action 05:29:47 INFO - Running main action method: download_and_extract 05:29:47 INFO - mkdir: /builds/slave/test/build/tests 05:29: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')]} 05:29:47 INFO - https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/test_packages.json 05:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/test_packages.json 05:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:30:15 INFO - Downloaded 1149 bytes. 05:30:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:30:15 INFO - Using the following test package requirements: 05:30:15 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:30:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:30:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'jsshell-mac.zip'], 05:30:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:30:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:30:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:30:15 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:30:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:30:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:30:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:30:15 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:30:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:15 INFO - https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:16 INFO - Downloaded 17458765 bytes. 05:30:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:30:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:30:21 INFO - Return code: 0 05:30:21 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:21 INFO - https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:22 INFO - Downloaded 17458765 bytes. 05:30:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:30:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:30:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:30:28 INFO - Return code: 0 05:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:28 INFO - https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:30:29 INFO - Downloaded 11131307 bytes. 05:30:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:30:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:30:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:30:29 INFO - Return code: 0 05:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:29 INFO - https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:30:32 INFO - Downloaded 108780295 bytes. 05:30:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:30:32 INFO - mkdir: /builds/slave/test/properties 05:30:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:32 INFO - Contents: 05:30:32 INFO - build_url:https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:30:32 INFO - Running post-action listener: _resource_record_post_action 05:30:32 INFO - Running post-action listener: set_extra_try_arguments 05:30:32 INFO - ##### 05:30:32 INFO - ##### Running populate-webroot step. 05:30:32 INFO - ##### 05:30:32 INFO - Running pre-action listener: _resource_record_pre_action 05:30:32 INFO - Running main action method: populate_webroot 05:30:32 INFO - Guessing talos json url... 05:30: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')]} 05:30:32 INFO - https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:30:33 INFO - Downloaded 99 bytes. 05:30:33 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:30:33 INFO - Contents: 05:30:33 INFO - 20151105030433 05:30:33 INFO - https://hg.mozilla.org/mozilla-central/rev/59c648a3f95524cb1ee42f2306c1db2698d35258 05:30: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')]} 05:30:33 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/59c648a3f9/testing/talos/talos.json 05:30:33 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/59c648a3f9/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/59c648a3f9/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:30:34 INFO - Downloaded 4264 bytes. 05:30:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:30:34 INFO - '../fennec_ids.txt'], 05:30:34 INFO - 'tests': ['tcheck2']}, 05:30:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:34 INFO - '--tppagecycles', 05:30:34 INFO - '7'], 05:30:34 INFO - 'tests': ['tsvgm']}}, 05:30:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'tests': ['damp', 'tps']}, 05:30:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['damp', 'tps']}, 05:30:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:34 INFO - 'other': {'tests': ['a11yr', 05:30:34 INFO - 'ts_paint', 05:30:34 INFO - 'tpaint', 05:30:34 INFO - 'sessionrestore', 05:30:34 INFO - 'sessionrestore_no_auto_restore']}, 05:30:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['a11yr', 05:30:34 INFO - 'ts_paint', 05:30:34 INFO - 'tpaint', 05:30:34 INFO - 'sessionrestore', 05:30:34 INFO - 'sessionrestore_no_auto_restore']}, 05:30:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['a11yr', 05:30:34 INFO - 'ts_paint', 05:30:34 INFO - 'tpaint', 05:30:34 INFO - 'sessionrestore', 05:30:34 INFO - 'sessionrestore_no_auto_restore']}, 05:30:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['a11yr', 05:30:34 INFO - 'ts_paint', 05:30:34 INFO - 'tpaint', 05:30:34 INFO - 'sessionrestore', 05:30:34 INFO - 'sessionrestore_no_auto_restore']}, 05:30:34 INFO - 'other_l64': {'tests': ['a11yr', 05:30:34 INFO - 'ts_paint', 05:30:34 INFO - 'tpaint', 05:30:34 INFO - 'sessionrestore', 05:30:34 INFO - 'sessionrestore_no_auto_restore']}, 05:30:34 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:34 INFO - 'ts_paint', 05:30:34 INFO - 'tpaint', 05:30:34 INFO - 'sessionrestore', 05:30:34 INFO - 'sessionrestore_no_auto_restore']}, 05:30:34 INFO - 'svgr': {'tests': ['tsvgx', 05:30:34 INFO - 'tsvgr_opacity', 05:30:34 INFO - 'tart', 05:30:34 INFO - 'tscrollx', 05:30:34 INFO - 'cart']}, 05:30:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['tsvgx', 05:30:34 INFO - 'tsvgr_opacity', 05:30:34 INFO - 'tart', 05:30:34 INFO - 'tscrollx', 05:30:34 INFO - 'cart']}, 05:30:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'tests': ['tp5o']}, 05:30:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'talos_options': ['--e10s'], 05:30:34 INFO - 'tests': ['tp5o']}, 05:30:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'talos_options': ['--xperf_path', 05:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:34 INFO - 'tests': ['tp5n']}, 05:30:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:34 INFO - 'talos_options': ['--e10s', 05:30:34 INFO - '--xperf_path', 05:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:30:34 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:30:34 INFO - 'tests': ['tp5n']}}, 05:30:34 INFO - 'talos.zip': {'path': '', 05:30:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:34 INFO - Running post-action listener: _resource_record_post_action 05:30:34 INFO - ##### 05:30:34 INFO - ##### Running create-virtualenv step. 05:30:34 INFO - ##### 05:30:34 INFO - Running pre-action listener: _resource_record_pre_action 05:30:34 INFO - Running main action method: create_virtualenv 05:30:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:34 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 05:30:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:34 INFO - Using real prefix '/tools/python27' 05:30:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:38 INFO - Installing pip.................done. 05:30:38 INFO - Return code: 0 05:30:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:30:38 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 05:30:38 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 05:30:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:30:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:38 INFO - 'HOME': '/Users/cltbld', 05:30:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:38 INFO - 'LOGNAME': 'cltbld', 05:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:38 INFO - 'MOZ_NO_REMOTE': '1', 05:30:38 INFO - 'NO_EM_RESTART': '1', 05:30:38 INFO - 'PAGER': '/bin/cat', 05:30:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:38 INFO - 'PWD': '/builds/slave/test', 05:30:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:38 INFO - 'SHELL': '/bin/bash', 05:30:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:30:38 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:30:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:38 INFO - 'USER': 'cltbld', 05:30:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:38 INFO - 'XPC_FLAGS': '0x0', 05:30:38 INFO - 'XPC_SERVICE_NAME': '0', 05:30:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:40 INFO - Cleaning up... 05:30:40 INFO - Return code: 0 05:30:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:30:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:30:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:40 INFO - 'HOME': '/Users/cltbld', 05:30:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:40 INFO - 'LOGNAME': 'cltbld', 05:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:40 INFO - 'MOZ_NO_REMOTE': '1', 05:30:40 INFO - 'NO_EM_RESTART': '1', 05:30:40 INFO - 'PAGER': '/bin/cat', 05:30:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:40 INFO - 'PWD': '/builds/slave/test', 05:30:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:40 INFO - 'SHELL': '/bin/bash', 05:30:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:30:40 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:30:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:40 INFO - 'USER': 'cltbld', 05:30:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:40 INFO - 'XPC_FLAGS': '0x0', 05:30:40 INFO - 'XPC_SERVICE_NAME': '0', 05:30:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:40 INFO - Downloading/unpacking psutil>=0.7.1 05:30:40 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 05:30:40 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 05:30:40 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 05:30:40 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 05:30:40 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 05:30:40 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 05:30:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:30:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:30:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:43 INFO - Installing collected packages: psutil 05:30:43 INFO - Running setup.py install for psutil 05:30:43 INFO - building 'psutil._psutil_osx' extension 05:30:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:30:45 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 05:30:45 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 05:30:45 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 05:30:45 INFO - building 'psutil._psutil_posix' extension 05:30:45 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 05:30:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:30:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:30:45 INFO - ^ 05:30:45 INFO - 1 warning generated. 05:30:45 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 05:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:45 INFO - Successfully installed psutil 05:30:45 INFO - Cleaning up... 05:30:45 INFO - Return code: 0 05:30:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:30:45 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')]} 05:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:45 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')]} 05:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:45 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 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:30:45 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 05:30:45 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 05:30:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:30:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:45 INFO - 'HOME': '/Users/cltbld', 05:30:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:45 INFO - 'LOGNAME': 'cltbld', 05:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:45 INFO - 'MOZ_NO_REMOTE': '1', 05:30:45 INFO - 'NO_EM_RESTART': '1', 05:30:45 INFO - 'PAGER': '/bin/cat', 05:30:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:45 INFO - 'PWD': '/builds/slave/test', 05:30:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:45 INFO - 'SHELL': '/bin/bash', 05:30:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:30:45 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:30:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:45 INFO - 'USER': 'cltbld', 05:30:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:45 INFO - 'XPC_FLAGS': '0x0', 05:30:45 INFO - 'XPC_SERVICE_NAME': '0', 05:30:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:46 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 05:30:46 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 05:30:46 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 05:30:46 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 05:30:46 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 05:30:46 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 05:30:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:48 INFO - Installing collected packages: mozsystemmonitor 05:30:48 INFO - Running setup.py install for mozsystemmonitor 05:30:48 INFO - Successfully installed mozsystemmonitor 05:30:48 INFO - Cleaning up... 05:30:48 INFO - Return code: 0 05:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:48 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')]} 05:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:48 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')]} 05:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:48 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 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:30:48 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 05:30:48 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 05:30:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:30:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:48 INFO - 'HOME': '/Users/cltbld', 05:30:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:48 INFO - 'LOGNAME': 'cltbld', 05:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:48 INFO - 'MOZ_NO_REMOTE': '1', 05:30:48 INFO - 'NO_EM_RESTART': '1', 05:30:48 INFO - 'PAGER': '/bin/cat', 05:30:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:48 INFO - 'PWD': '/builds/slave/test', 05:30:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:48 INFO - 'SHELL': '/bin/bash', 05:30:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:30:48 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:30:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:48 INFO - 'USER': 'cltbld', 05:30:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:48 INFO - 'XPC_FLAGS': '0x0', 05:30:48 INFO - 'XPC_SERVICE_NAME': '0', 05:30:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:49 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 05:30:49 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 05:30:49 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 05:30:49 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 05:30:49 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 05:30:49 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 05:30:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:51 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 05:30:51 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 05:30:51 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 05:30:51 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 05:30:51 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 05:30:51 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 05:30:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:52 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 05:30:52 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 05:30:52 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 05:30:52 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 05:30:52 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 05:30:52 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 05:30:52 INFO - Downloading docopt-0.6.1.tar.gz 05:30:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:52 INFO - Running setup.py install for blobuploader 05:30:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:52 INFO - Running setup.py install for requests 05:30:53 INFO - Running setup.py install for docopt 05:30:53 INFO - Successfully installed blobuploader requests docopt 05:30:53 INFO - Cleaning up... 05:30:53 INFO - Return code: 0 05:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:53 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 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:30:53 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 05:30:53 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 05:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:53 INFO - 'HOME': '/Users/cltbld', 05:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:53 INFO - 'LOGNAME': 'cltbld', 05:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:53 INFO - 'MOZ_NO_REMOTE': '1', 05:30:53 INFO - 'NO_EM_RESTART': '1', 05:30:53 INFO - 'PAGER': '/bin/cat', 05:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:53 INFO - 'PWD': '/builds/slave/test', 05:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:53 INFO - 'SHELL': '/bin/bash', 05:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:30:53 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:53 INFO - 'USER': 'cltbld', 05:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:53 INFO - 'XPC_FLAGS': '0x0', 05:30:53 INFO - 'XPC_SERVICE_NAME': '0', 05:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:53 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-3UhMKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-2GE2e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-dWOmR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-x2f3M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-etuzqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-HpOm3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-GOC5b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-I8VhZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-P00e0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:54 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-2FCChG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-3tLUVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-r3THFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-iE9uT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-m0WEWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-7iVgzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-TZEI_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:55 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-EAfarA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:55 INFO - Running setup.py install for manifestparser 05:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:56 INFO - Running setup.py install for mozcrash 05:30:56 INFO - Running setup.py install for mozdebug 05:30:56 INFO - Running setup.py install for mozdevice 05:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:56 INFO - Running setup.py install for mozfile 05:30:56 INFO - Running setup.py install for mozhttpd 05:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:56 INFO - Running setup.py install for mozinfo 05:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Running setup.py install for mozInstall 05:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Running setup.py install for mozleak 05:30:57 INFO - Running setup.py install for mozlog 05:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Running setup.py install for moznetwork 05:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:57 INFO - Running setup.py install for mozprocess 05:30:57 INFO - Running setup.py install for mozprofile 05:30:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:58 INFO - Running setup.py install for mozrunner 05:30:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:58 INFO - Running setup.py install for mozscreenshot 05:30:58 INFO - Running setup.py install for moztest 05:30:58 INFO - Running setup.py install for mozversion 05:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:58 INFO - Cleaning up... 05:30:58 INFO - Return code: 0 05:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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', '-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 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:30:58 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 05:30:58 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 05:30:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:30:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:58 INFO - 'HOME': '/Users/cltbld', 05:30:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:58 INFO - 'LOGNAME': 'cltbld', 05:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:58 INFO - 'MOZ_NO_REMOTE': '1', 05:30:58 INFO - 'NO_EM_RESTART': '1', 05:30:58 INFO - 'PAGER': '/bin/cat', 05:30:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:58 INFO - 'PWD': '/builds/slave/test', 05:30:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:58 INFO - 'SHELL': '/bin/bash', 05:30:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:30:58 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:30:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:58 INFO - 'USER': 'cltbld', 05:30:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:58 INFO - 'XPC_FLAGS': '0x0', 05:30:58 INFO - 'XPC_SERVICE_NAME': '0', 05:30:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-S6iMIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:59 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)) 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-08GZ38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:59 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)) 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-fUyJCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:59 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)) 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-gFf8xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-V0JsMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:59 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)) 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-b09bxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:59 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)) 05:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:59 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-6eqPWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-OmCEhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-dnwjW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-yCit4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-SUI0BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-QXsYsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-BJVTAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-5tDhG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:00 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)) 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:00 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-WkVqQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:01 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)) 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:01 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-GDJ8wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:01 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)) 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:01 INFO - Running setup.py (path:/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/pip-lDk3F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:01 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)) 05:31:01 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)) 05:31:01 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)) 05:31:01 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)) 05:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:01 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 05:31:01 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 05:31:01 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 05:31:01 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 05:31:01 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 05:31:01 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 05:31:03 INFO - Downloading blessings-1.5.1.tar.gz 05:31:03 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 05:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:03 INFO - Installing collected packages: blessings 05:31:03 INFO - Running setup.py install for blessings 05:31:04 INFO - Successfully installed blessings 05:31:04 INFO - Cleaning up... 05:31:04 INFO - Return code: 0 05:31:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:04 INFO - Reading from file tmpfile_stdout 05:31:04 INFO - Current package versions: 05:31:04 INFO - blessings == 1.5.1 05:31:04 INFO - blobuploader == 1.2.4 05:31:04 INFO - docopt == 0.6.1 05:31:04 INFO - manifestparser == 1.1 05:31:04 INFO - mozInstall == 1.12 05:31:04 INFO - mozcrash == 0.16 05:31:04 INFO - mozdebug == 0.1 05:31:04 INFO - mozdevice == 0.47 05:31:04 INFO - mozfile == 1.2 05:31:04 INFO - mozhttpd == 0.7 05:31:04 INFO - mozinfo == 0.9 05:31:04 INFO - mozleak == 0.1 05:31:04 INFO - mozlog == 3.0 05:31:04 INFO - moznetwork == 0.27 05:31:04 INFO - mozprocess == 0.22 05:31:04 INFO - mozprofile == 0.27 05:31:04 INFO - mozrunner == 6.11 05:31:04 INFO - mozscreenshot == 0.1 05:31:04 INFO - mozsystemmonitor == 0.0 05:31:04 INFO - moztest == 0.7 05:31:04 INFO - mozversion == 1.4 05:31:04 INFO - psutil == 3.1.1 05:31:04 INFO - requests == 1.2.3 05:31:04 INFO - wsgiref == 0.1.2 05:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:04 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 0x106b7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106be9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede2e01cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, '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.IFVuVcjWES/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.2IYKzn6MVT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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 05:31:04 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 05:31:04 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 05:31:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:31:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:04 INFO - 'HOME': '/Users/cltbld', 05:31:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:04 INFO - 'LOGNAME': 'cltbld', 05:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:04 INFO - 'MOZ_NO_REMOTE': '1', 05:31:04 INFO - 'NO_EM_RESTART': '1', 05:31:04 INFO - 'PAGER': '/bin/cat', 05:31:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:04 INFO - 'PWD': '/builds/slave/test', 05:31:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:04 INFO - 'SHELL': '/bin/bash', 05:31:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:31:04 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:31:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:04 INFO - 'USER': 'cltbld', 05:31:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:04 INFO - 'XPC_FLAGS': '0x0', 05:31:04 INFO - 'XPC_SERVICE_NAME': '0', 05:31:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 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)) 05:31:04 INFO - Cleaning up... 05:31:04 INFO - Return code: 0 05:31:04 INFO - Running post-action listener: _resource_record_post_action 05:31:04 INFO - Running post-action listener: _start_resource_monitoring 05:31:04 INFO - Starting resource monitoring. 05:31:04 INFO - ##### 05:31:04 INFO - ##### Running install step. 05:31:04 INFO - ##### 05:31:04 INFO - Running pre-action listener: _resource_record_pre_action 05:31:04 INFO - Running main action method: install 05:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:05 INFO - Reading from file tmpfile_stdout 05:31:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:05 INFO - Reading from file tmpfile_stdout 05:31:05 INFO - Output received: 05:31:05 INFO - Usage: mozinstall [options] installer 05:31:05 INFO - Options: 05:31:05 INFO - -h, --help show this help message and exit 05:31:05 INFO - -d DEST, --destination=DEST 05:31:05 INFO - Directory to install application into. [default: 05:31:05 INFO - "/builds/slave/test"] 05:31:05 INFO - --app=APP Application being installed. [default: firefox] 05:31:05 INFO - mkdir: /builds/slave/test/build/application 05:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:31:43 INFO - Reading from file tmpfile_stdout 05:31:43 INFO - Output received: 05:31:43 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:31:43 INFO - Running post-action listener: _resource_record_post_action 05:31:43 INFO - ##### 05:31:43 INFO - ##### Running run-tests step. 05:31:43 INFO - ##### 05:31:43 INFO - Running pre-action listener: _resource_record_pre_action 05:31:43 INFO - Running main action method: run_tests 05:31:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:43 INFO - 2015-11-05 05:31:43.849 screenresolution[1628:8036] starting screenresolution argv=screenresolution get 05:31:43 INFO - 2015-11-05 05:31:43.852 screenresolution[1628:8036] Display 0: 1600x1200x32@60 05:31:43 INFO - 2015-11-05 05:31:43.859 screenresolution[1629:8038] starting screenresolution argv=screenresolution list 05:31:43 INFO - Available Modes on Display 0 05:31:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:44 INFO - Intel HD Graphics 3000: 05:31:44 INFO - Chipset Model: Intel HD Graphics 3000 05:31:44 INFO - Type: GPU 05:31:44 INFO - Bus: Built-In 05:31:44 INFO - VRAM (Total): 512 MB 05:31:44 INFO - VRAM (Dynamic, Max): 10 05:31:44 INFO - Vendor: Intel (0x8086) 05:31:44 INFO - Device ID: 0x0116 05:31:44 INFO - Revision ID: 0x0009 05:31:44 INFO - Displays: 05:31:44 INFO - Display: 05:31:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:44 INFO - Display Serial Number: 1600x1200 60 05:31:44 INFO - Main Display: Yes 05:31:44 INFO - Mirror: Off 05:31:44 INFO - Online: Yes 05:31:44 INFO - Rotation: Supported 05:31:44 INFO - Return code: 0 05:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:44 INFO - Python 2.7.3 05:31:44 INFO - Return code: 0 05:31:44 INFO - grabbing minidump binary from tooltool 05:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:44 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 0x106b319f0>, '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 0x106890cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106afb990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:44 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 05:31:44 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 05:31:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:44 INFO - Return code: 0 05:31:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:31:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:31:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0070', '--webServer', 'localhost'] in /builds/slave/test/build 05:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0070 --webServer localhost 05:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFVuVcjWES/Render', 05:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:44 INFO - 'HOME': '/Users/cltbld', 05:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:44 INFO - 'LOGNAME': 'cltbld', 05:31:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:44 INFO - 'MOZ_NO_REMOTE': '1', 05:31:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:44 INFO - 'NO_EM_RESTART': '1', 05:31:44 INFO - 'PAGER': '/bin/cat', 05:31:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:44 INFO - 'PWD': '/builds/slave/test', 05:31:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:44 INFO - 'SHELL': '/bin/bash', 05:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2IYKzn6MVT/Listeners', 05:31:44 INFO - 'TMPDIR': '/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/', 05:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:44 INFO - 'USER': 'cltbld', 05:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:44 INFO - 'XPC_FLAGS': '0x0', 05:31:44 INFO - 'XPC_SERVICE_NAME': '0', 05:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:31:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0070', '--webServer', 'localhost'] with output_timeout 3600 05:31:44 INFO - mozversion INFO | application_buildid: 20151105030433 05:31:44 INFO - mozversion INFO | application_changeset: 59c648a3f95524cb1ee42f2306c1db2698d35258 05:31:44 INFO - mozversion INFO | application_display_name: Nightly 05:31:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:44 INFO - mozversion INFO | application_name: Firefox 05:31:44 INFO - mozversion INFO | application_remotingname: firefox 05:31:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:31:44 INFO - mozversion INFO | application_vendor: Mozilla 05:31:44 INFO - mozversion INFO | application_version: 45.0a1 05:31:44 INFO - mozversion INFO | platform_buildid: 20151105030433 05:31:44 INFO - mozversion INFO | platform_changeset: 59c648a3f95524cb1ee42f2306c1db2698d35258 05:31:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:31:44 INFO - mozversion INFO | platform_version: 45.0a1 05:31:44 INFO - 2015-11-05 05:31:44,616 DEBUG : using testdate: 1446730304 05:31:44 INFO - 2015-11-05 05:31:44,616 DEBUG : actual date: 1446730304 05:31:44 INFO - 2015-11-05 05:31:44,726 INFO : starting webserver on 'localhost:49268' 05:31:44 INFO - 2015-11-05 05:31:44,728 INFO : Starting test suite t-yosemite-r5-0070 05:31:44 INFO - 2015-11-05 05:31:44,728 INFO : Starting test dromaeo_css 05:31:44 INFO - 2015-11-05 05:31:44,728 DEBUG : operating with platform_type : mac_ 05:31:44 INFO - 2015-11-05 05:31:44,729 INFO : Initialising browser for dromaeo_css test... 05:31:44 INFO - 2015-11-05 05:31:44,759 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/tmpY2jPbu/profile http://localhost:49268/getInfo.html 05:31:47 INFO - 2015-11-05 05:31:47,914 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:47 INFO - 2015-11-05 05:31:47,914 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:47 INFO - 2015-11-05 05:31:47,914 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:31:47 INFO - 2015-11-05 05:31:47,915 DEBUG : BROWSER_OUTPUT: __metrics 05:31:47 INFO - 2015-11-05 05:31:47,931 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:48 INFO - 2015-11-05 05:31:48,699 INFO : Browser initialized. 05:31:48 INFO - 2015-11-05 05:31:48,699 INFO : Running cycle 1/1 for dromaeo_css test... 05:31:48 INFO - 2015-11-05 05:31:48,699 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/tmpY2jPbu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:32:00 INFO - 2015-11-05 05:32:00,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 222416896 05:32:00 INFO - 2015-11-05 05:32:00,703 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-05 05:32:51,716 DEBUG : BROWSER_OUTPUT: 1446730371712 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] 05:35:02 INFO - 2015-11-05 05:35:02,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 05:35:03 INFO - 2015-11-05 05:35:03,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 319959040 05:35:03 INFO - 2015-11-05 05:35:03,831 DEBUG : BROWSER_OUTPUT: 05:38:06 INFO - 2015-11-05 05:38:06,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 05:38:07 INFO - 2015-11-05 05:38:07,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 355282944 05:38:07 INFO - 2015-11-05 05:38:07,197 DEBUG : BROWSER_OUTPUT: 05:41:09 INFO - 2015-11-05 05:41:09,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 05:41:10 INFO - 2015-11-05 05:41:10,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 318717952 05:41:10 INFO - 2015-11-05 05:41:10,072 DEBUG : BROWSER_OUTPUT: 05:44:12 INFO - 2015-11-05 05:44:12,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 05:44:12 INFO - 2015-11-05 05:44:12,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 311091200 05:44:12 INFO - 2015-11-05 05:44:12,741 DEBUG : BROWSER_OUTPUT: 05:47:15 INFO - 2015-11-05 05:47:15,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 05:47:16 INFO - 2015-11-05 05:47:16,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 312737792 05:47:16 INFO - 2015-11-05 05:47:16,562 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 05:50:19 INFO - 2015-11-05 05:50:19,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 362246144 05:50:19 INFO - 2015-11-05 05:50:19,786 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,786 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:19 INFO - 2015-11-05 05:50:19,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:19 INFO - 2015-11-05 05:50:19,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:19 INFO - 2015-11-05 05:50:19,786 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:19 INFO - 2015-11-05 05:50:19,787 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2816.7324104210106;2839.971600283999;2873.7269959353853;2889.566565015246;3117.7349925256353;4631.421072365954;4713.457952335482;4721.811127554898;4721.952780472194;4746.145693775119;4636.165490211761;4670.766461676911;4672.6261899047995;4701.083288758693;4716.174669432844;4293.334533147367;4306.160298741746;4320.28715261983;4366.061296821183;4398.098389830077;4361.040571074359;4390.034192477649;4391.890202744925;4432.3573081903105;4469;4147.502299724022;4246.808893599765;4296.935545966813;4360.040791025969;4380.321050237202;4080.8163632636306;4240.830366785356;4246.2356775780345;4307.91384172318;4331.913361732779;4276.144771045772;4279.614834664895;4314.9784251078545;4401.955980440187;4424.048829501673;4506.414166158411;4562.384078149441;4608.769561521911;4689.249720044811;4702.4827269000725;4911.631627627907;4937.901241975141;4989.57588604969;5056.241563765465;5086.364204474441;4991.725455099968;5017.523335283142;5019.297298378194;5050.343455350818;5062.721550314731;4546.408966834357;4579.038401935631;4642.46611639659;4666.020135771492;4705.95294047062;4869.756512174377;5180.585553155738;5190.6107041972;5205.7397130143345;5249.42256351801;4841.8547443576745;4910.705357678551;4931.457539670633;4939.3084968104495;4969.652124351333;4946.159152944008;5077;5090.312807770978;5092.770825312869;5099.235114732745;4847.684900481458;4923.630727695438;4944.233643785219;4945.134601444733;4946.727929963815;5027.974860125676;5030.496950305013;5043.041822053798;5083.567896728746;5097.668651537638;3753.6246375362794;3767.9811600942367;3844.692424606025;3908.5700572936953;3939.212157568498;3475.304939012208;3575.8927232183078;3609.115766637138;3617.5297211362354;3617.94573081404;4640.698354607007;4712.5758681718125;4745.715257084586;4760.238361862085;4769.2369220925175;5040.899182016413;5043.722595257223;5046.6719663221775;5050.444451110375;5173.042987047408;4624.791884365144;4636.884077898012;4763.809447622126;4767.73777442244;4775.068861572029;4489.416375871116;4508.549145085465;4523.88690282739;4531.410916580823;4555.498895121534;5165.560927321145;5167.405748338989;5168.922466162935;5243.10867152585;5246.475352464876;4915.287283343967;4934.901301973869;5050.797968081236;5055.6713813602;5132.409772876018;5086.338775959101;5144.819931302536;5161.7677204525135;5165.767540460613;5182.663126896739;5027.170516864822;5028.296038554532;5030.547250747451;5072.467390924047;5085.4406015337545;4899.1426500363;4969.35398398206;5015.072211640858;5023.598112151092;5091.236314552847;4935.580475659609;4945.530174633404;4978.800847966041;5023.57299629521;5127.769250383667;4822.252550854623;4913.70517768935;4929.679570827885;4932.506749325039;5005.674631148963;4683.765811709469;4724.763761811827;4859.586935110555;4918.950810491992;5032.748362581783;4953;4960.8759781005765;5009.423916249678;5013.39839219296;5047.697138171721;4907.754612269444;4954.355933728592;4981.103401387785;4981.900361992813;5005.874853128701 05:50:19 INFO - 2015-11-05 05:50:19,787 DEBUG : BROWSER_OUTPUT: |1;ext.html;484.58567924424614;488.79470622338613;500.08484473413654;512.5643203277212;516.9712272577569;27960.720392796065;28643.140705778835;33928.66071339289;34672.82663586685;34717.652823471755;37542;37706.81146594263;37774.24451510975;37946.430803537965;38047.42928856063;7470.813229669275;8360.080391156984;8420.873686894702;8441.662333506652;8543.316534677242;7517.661705223278;9856.507174641276;10080.04239597237;10158.847617285746;10189.133923616502;9899.802003959916;9998.900010999905;10048.899511004869;10070.546825392876;10100;7605.581693006882;7624.695012199505;9763.755906102333;9931.950340248324;9994.350367226143;9792.21662267017;9813.90186098137;9857.802843943153;9874.703758887244;9936.155426788731;36435.27129457396;36918.26163476742;37209.62790372116;37443.62556374429;37497;2646.8411895286345;2701.716319786414;2759.2550011496983;2842.5025620516326;3181.411438883814;24986;25028;25073.874630626913;25134;25495.23514294574;2180.7274090738656;2196.8242540596875;2209.823214142865;2217.1020736601704;2218.3455880515285;258720;262690;262742;262789;263372;55940;56082.71958640181;56194;57082.429175708545;57084;55552.72223638856;56664.43335566674;65511.34488655148;66842;67692.66153669299;13366.26485543285;13409.195448273134;13537.390817413043;13677.452901884013;13752.243626600433;10091;10157.085862272432;10158.796824063478;10159.44123073238;10172.491375431198;18554.44336669902;18770.84135324428;18775.248990040247;18806;18943.24227030931;7754.961225193951;7956.443048986631;8000.959995199987;8002.3598112150885;8048.315893149148;795.9562224077731;843.3548335523329;862.9946112778669;863.0765081363007;969.1762002297991;25580.863565413594;25752;25816.74183258181;25823.741762582133;26003;945.5177859291811;970.2529052629436;995.4525011243787;1022.754538910656;1095.052779345876;13425.194488330731;13473.797893031613;13553.818100067483;13630.727385452235;13634.318284085755;344937;350401;350578;351393;351932;53747.46252537503;53822;54601.45398546043;54621.453785461636;54959;1212.4119801896074;1218.3908045977012;1218.7440637466054;1220.5422966387605;1223.3638507975982;25527.6170857441;25937.22188334353;26004.479910401307;26018;26114.477710446066;42804.077531084324;42871;43084.78457607692;43108.568914310454;43309;255953.36303140238;259632;259898;260623;261415;30012.849935750182;41861.79069104635;42533.59731221433;42741.35887961621;42790.57209427866;38822.80588597039;39872.401913971895;40340.59659403486;40438;40677.1864562713;33417.49873751847;33707.82022629196;33933.49099763555;34031.82984085064;34249.657503425646;28336.291592710346;32415.35169296648;33947.15132121717;36593.634063659025;37201.25597488089;33331.333373332884;33430.16424589307;33662.83168584141;33926.830365848014;33980;27342.863285683445;28503.714962850936;29210;29217.26956826011;29387.559186612645;20949.790502094784;23099.769002310433;23230.51177660691;23434.64848027247;24036.759632403453 05:50:19 INFO - 2015-11-05 05:50:19,787 DEBUG : BROWSER_OUTPUT: |2;jquery.html;290.31196065325184;291.7578409919767;295.5994627280036;299.0669112369407;299.5641341847613;12842;13260.138091024077;15557;16275.430359937405;16691.666166676674;13305.800412993813;15364.923175384136;15544.300506477208;15973.840261597381;15982.84017159831;4132.938005929914;4268.551802060785;4280.122574872144;4781.258904869751;4951.405831300249;2995.0415866922594;3103.0070377479215;4197.07664313852;4251.06476575153;4306.332518459643;4202.810873510684;4232.830686772525;4256.808443620044;4259.212045771542;4269.658427325807;4157.334826427757;4251.87244382669;4254.91490170198;4255.17024180285;4274.316109422493;3561.821908904544;3577.713782897362;3580.3018411409785;3587.336342776595;3591.0124715703128;11145.387003714792;11425.200235983484;11623.825642615368;11634.127440441916;11946.581869634609;1604.5908293385228;1657.3784830688492;1701.5235733994377;1712.940047098358;1795.9102044897702;8321.500709957361;8360.665573377057;8522.40343175978;8570.142985701443;8574.657013719443;1402.249796358943;1412.4844431782326;1412.7245187188503;1439.2731670506432;1459.109942934809;47018.764906175595;48018.27972580414;48315.75842120802;48472.51527484715;49287;5598.3282006159525;5625.059354522683;5626.437356264422;5686;5720.971395143081;6379.681015949184;6383.744650214032;6433.420992110732;6447.097406363113;6453.9351007083305;4590.816367345269;4632.72203667781;4655.953440465552;4661.394018777537;4706.835260765925;4892.779824907888;4902.607791376681;4990.850274491771;5002;5026.824061157842;2538;2547.4013606802387;2553.936151596225;2557.820952533305;2571.8555242916723;886.9512176830336;888;896.3904544909394;900.2482926756232;954.7326748510428;334.35135836477156;342.9279851231269;371.6766413220515;371.68035489479024;408.9468369112056;9589.664361747446;10243.897561024294;10566.788664226826;10604.575816967235;10719.713634363927;337.73319077928653;389.9064224586079;389.91811719539214;409.22451953548455;410.2287699125625;5316.548093412026;5428.158635411518;5455.18172274162;5482.753276102585;5521.558275337963;488813;493026;497392;510819;512702;66644;67626.66186669134;67631.66184169146;67777;69406.65296673484;445.7815670321584;447.59045473391484;448.60746846509306;451.87799294190387;453.53739186030066;9369.953150234205;9412.529373531434;9425.717228483156;9635;9673.951630241803;29375.412491750474;30604.08187754371;30727.385452291277;31165.376692466478;31190.37619247557;41829;42269.154616906875;42412;42601.786991064844;42605.5739442614;5251;5370.2213179089595;5433.239346491573;5444.074507333842;5461;10356.948215258875;10462.529186186488;10542.051215390651;10592.311499752492;10626.574937002742;8506.149385061444;8997.460152390877;9115.817683646157;9203.76990575241;9270.72187834366;8782.736517904474;8784.253338466302;8814.823703526023;8821.955890220508;8942.642294308154;8880.245179159843;9219.907800922174;9270.768230794283;9304.627814887599;9363.157315841607;4853.927191092207;4912.361393018885;4917.9016419672125;5335;5362.919556206738;8539;8810.911890881265;8965.865007763658;9028.638854446011;9049.864252036094 05:50:19 INFO - 2015-11-05 05:50:19,791 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1182.9881701182985;1567.8902476826622;1608.9034657920517;1656.1719140429784;1666.191896929989;6040.063790112534;6213.068039794033;6509.837254068645;6626.5030122740745;6638.668066596675;6549.77075802347;6658.134442522465;6667.833304167386;6689.193917642234;6734.865302693943;1913.5981443896728;1915.3870761356372;1915.9616807663838;1940.602176553803;1940.9514762130918;1956.1295223625493;1961.2743284984576;1975.733276007735;1985.553250518629;2019.162047750182;1943.2906988949073;1946.124244090158;1958.3243780895639;1963.2245263121058;1963.9214431422727;1833.8716289859715;1867.7198420236937;1877.0145673521374;1885.0857334192906;1892.858035647332;1915.7413749143827;1944.202876820511;1953.7460130182985;1961.0586918279305;1973.5559499112728;6019.127226552169;6565.770198043093;6642.468602511787;6658.234303055162;6714.966425167843;3734.7572407793405;4006.8597599084183;4095.058136628592;4116.197341518405;4127.463429754142;2403.399150212447;2499.5875680512695;2546.315920708141;2567.9101231457;2573.4595734895693;745.9589722565257;746.6304179431216;759.9506032107895;779.6569509415896;782.5617654113714;8500.659973601048;8520.659173633047;8546.743597692079;8586.527740974245;8590.355723320776;3650.4889315495852;3680.392735198662;3709.8145092745253;3715.888523344304;3764.7176461765475;7523.473356865076;7607.695692172251;7612.3148916596665;7630.542167469858;7639.923600763921;4172.4144824966315;4189.769562674082;4204.726692764961;4208.91582168361;4219.852305169305;3813.447050177764;3843.135294558758;3847.826847791856;3847.9807600962376;3848.3842585186794;3028.227801910499;3040.467918114321;3074.0624109646774;3113.610798650169;3126.0621813455873;955.4649396338073;958.5159494455255;965.0831709875506;967.7967626798451;969.1665167955553;945.7021038373028;982.8034393121404;1148.0987424871603;1178.7878181927335;1193.7493126443544;6303.338149494329;6316.684165791692;6319.747210111544;6387.744490220339;6433.646149461731;1027.2347101409498;1028.2956175019985;1044.154235069596;1048.3552615141632;1064.7710742190466;5045.091883460939;5077.086124497552;5079.619028572872;5083.974580127149;5116.513931176532;7109.537880037781;7310.634468276565;7398.223186565441;7726.420518461138;7760.767176984699;7607.505512141693;7621.695132194761;7636.579988100597;7663.19536448676;7677.385809135256;6088;6224.439800417984;6250.593711408744;6289.8742025159245;6293.874122517524;6200.441960223601;6225.8132256032395;6250.406211409909;6254.343293954252;6258.812235632939;6901.827454313682;6981.79054628362;7013.123359580052;7033.824154396181;7041.929580704127;7005.614691192033;7143.357097861218;7184.497085203986;7291.234420385783;7295.854082918206;5664.943350566607;5721.713914304351;5740.799072032459;5752.798652047159;5772.913406298993;6380.840478988062;6401.679916004275;6445.452136568444;6458.644774537445;6509.609423434609;5811.883762324645;6011.27864656244;6050.697465126814;6160.507159427146;6161.322254551906;5852.882942341214;5892.145638882424;5909.586328957103;5960.5231581474245;5971.91042134377;5978.521718262442;5998.520118390606;6021.2473440819895;6024.036154215304;6054.182685337423;5414.756335964812;5492.505674489315;5506.2291279221745;5537.640053396516;5537.889242215053;5566.554675625859;5588.273524441796;5630.605857590093;5655.773769049192;5661.207430959586 05:50:19 INFO - 2015-11-05 05:50:19,791 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.3185864984163;275.4353575170899;279.42159729360225;282.1254112252018;283.8523967536882;5349.358077030752;5397.109476936301;5444.292242008533;5486.451354864512;5493.697846618435;5330.813421530247;5371.194320851874;5397.082495975684;5422.267993820833;5426.511613954744;4150.107726838722;4155.981784462796;4157.771322577257;4177.227212965611;4187.371894215861;3986.063275130342;4058.8985275368204;4112.239235741397;4125.7524548527035;4148.958510414887;4097.364908439182;4098.241825262321;4128.195001974616;4135.503739551258;4140.565240649734;4084.8978775530554;4092.406601042862;4111.342185250375;4120.91758164838;4154.0030392705685;3519.6128425873135;3547.2373439710586;3558.5018097466377;3560.839762210681;3574.1422058705725;5177.663451875654;5246.842594722164;5252.553532949704;5259.76331065103;5280.498352656491;4676.485586585472;4687.671862969593;4696.506866778973;4701.247800351927;4708.387909571768;5623.803166889139;5644.899244647296;5690;5708.372079071299;5710.486056254916;3857.8842634721004;3871.632194941476;3888.591697871711;3890.008047947755;3896.5713771485116;5612.466815652507;5764.279465066867;5803.129530570406;5899.646021238739;5909.143174239754;3883.514560679915;3886.5336159660455;3901.122247494291;3915.5497117831815;3958.44581758554;3959.4456776051375;3996.600339966038;4012.879613611596;4019.256437559061;4019.296623091006;4598.471175814824;4635.188841952645;4636.374089497875;4648.604868586208;4652.883677908079;5578.0517312057045;5738.454846789548;5759.740811663485;5781.1328300754385;5782.392848750905;1434.6126545832567;1437.1879887863324;1444.3716983112379;1459.9051061681168;1460.218782951116;924.2282693950626;927.0960813207204;938.6104766521817;938.8075444533854;945.8108378324363;5492.093804522209;5513.393526712059;5530;5548.72256387179;5554.583406244547;5964.135200395918;5970.0746384310505;5976.910346344721;5983.61106528083;6004.54965877561;5470.288862447856;5514.779408823682;5526.834194974157;5531.3362396512675;5556.083246264321;3181.538676891838;3247.4641684121857;3256.5929258842643;3265.5754751882578;3294.028261662815;5959.493443057302;5980.5514586405325;6005.6396616203165;6016.608920420246;6074.7266373012435;6084.330723620398;6112.969435152885;6115.755369785248;6129.11127886454;6146.477549408351;5836.474717275551;5993.880122397441;6012.969935150384;6028.0355143176885;6035.758569657164;5937.732802023833;5951.256092988377;5967.582269241111;5979.073243647242;5985.551083668829;5776.451237132465;5781.21953536284;5836.153757705194;5853.64878107315;5857.677827719516;5835.79574714883;5846.736896839568;5907.054871220584;5950.821475355746;6001.549883758648;3827.73205875586;3940.7241493095207;3942.2115576884166;3976.4035394691027;3984.641382275609;5862.882742345044;5868.677222752619;5877.588568800143;5913.467787898938;5929.258842644669;5608.046632072476;5714.285714285715;5757.050086735641;5776.104703770922;5801.100829371454;5732.856678583069;5734.168545560787;5775.624584402;5829.8251052468495;5868.471837534642;5583.050881350099;5598.356189038313;5638.661680299195;5656.632318899258;5696.316442026983;5753.165790960204;5755.223044888887;5829.271341082364;5837.970810145922;5847.707614619337;5589.245451863946;5697;5747.310322761128;5764.423557644202;5802.564807639528 05:50:19 INFO - 2015-11-05 05:50:19,795 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.1043477826657;700.6636814329122;704.3238491048589;718.8059224009518;742.3244847189059;12691.36543172841;12704.364781760922;12807.167534110276;12838.743225135504;12932.48270069196;11949.940250298758;12041.939790301058;12167.695807604814;12169;12180.878191218086;642.8457170279146;663.5090033375292;816.0859836982588;830.7175560309508;837.5519097282955;822.0956947357888;825.9545724985123;829.9170082991712;840.306746933779;840.306746933779;862.4782006885838;869.5826003518315;880.295763389286;881.9867701984475;882.0429833630486;640.6348381422591;678.4165617568912;821.5399376349204;842.2503971465401;850.0437008365589;626.2234828812285;626.2485017978444;626.4862812493757;627.2191122053027;631.1794666932968;11845.526178952832;12011.279323240633;12032.578859739868;12130.939345303304;12212.755744885142;10482.68551943443;10661.84007239892;10797.352158870493;10814.74611176765;10990.670279891616;8279.37904657147;8370.874436883452;8552.341618259514;8557.058723540405;8809.735707928772;2572.1897602255417;2752.5320695481614;2950.8819647214086;3042.497987832005;3073.1087984484475;40062.39906401406;42707;42798.1440371194;43003.78498107521;43159;5813.941860581424;5815.127730840408;5826.425646659326;5888.322842873039;5986;10457.529411176363;10562.471876406149;10568.682939511827;10591.84112238317;10676.893231067745;5549.278593782863;5587.804426845122;5718.571107166979;5759.539236861041;5798.797042103506;3430.3482338355634;3444.6555344465855;3503.194265318991;3545.6099829018785;3578.767380120336;2233.9106435742387;2274.510980139245;2280.201929324723;2290.301458055309;2291.0034135151263;341.90768492506885;349.7237182625748;353.36218126282307;354.03525393303045;354.2631326840166;412.056390864922;444.4044979727181;446.75875027485444;470.0797243261316;508.88550076232553;6669.284021051508;7029.92970070303;7077.610731409719;7178.748743794046;7318.926810731825;429.4931980263257;449.76836928980947;534.7433232048638;563.5125616341835;566.4590316247974;3184.50640150777;3224.822634755111;3394.728421726256;3538.5930617978747;3546.1666508370513;57804.71097644485;58316;58331.70834145802;58499.4150058494;59262.40737592655;45899.311510326705;46708;47796.761016194694;48216.27675584869;48544.27183592249;41915.580844191776;42255.7887210562;42393.576064238965;43108.35337469941;44085.11829763387;7326.780196594111;7359.632018399166;7370.926290737024;7401.777946661608;7464.216257292906;31135.68864311328;31594.210144745644;31804.204894877814;32306.35387292194;32669.346613068083;37141.257174856895;37807.24385512219;38935.61064389433;42594;43110;6627.900581491378;6893.276205998499;6947.652617369213;6964;7043.119610048744;9419.387739796892;9564.617415303588;9580.56887440053;9680.128788409076;9704.369216000938;9484.383515071499;9605.18355939753;9687.128158465772;9793.608255669693;9849;9449.622015119594;9684.56419461112;9723.611055557698;9728.708138755848;9729.854052189365;9144.679936202467;9394.812103758024;9405.43567385959;9424.670136545463;9555.23558115363;8075.2587393064205;8086.6361013755695;8127.268545830903;8404.495730256203;8540.786480338042;7956.880646790187;7974.960125199337;8042.638081286239;8070.798230044295;8093.87859182101 05:50:19 INFO - 2015-11-05 05:50:19,795 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:19 INFO - 2015-11-05 05:50:19,796 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:50:19 INFO - 2015-11-05 05:50:19,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,853 05:50:19 INFO - 2015-11-05 05:50:19,796 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:50:19 INFO - 2015-11-05 05:50:19,796 DEBUG : BROWSER_OUTPUT: __startTimestamp1446731419780__endTimestamp 05:50:19 INFO - 2015-11-05 05:50:19,796 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,796 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:19 INFO - 2015-11-05 05:50:19,797 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:50:19 INFO - 2015-11-05 05:50:19,797 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,797 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4692.94 Median:4899.14 stddev:496.11 (10.1%) stddev-sans-first:475.29 05:50:19 INFO - 2015-11-05 05:50:19,797 DEBUG : BROWSER_OUTPUT: Values: 2816.7 2840.0 2873.7 2889.6 3117.7 4631.4 4713.5 4721.8 4722.0 4746.1 4636.2 4670.8 4672.6 4701.1 4716.2 4293.3 4306.2 4320.3 4366.1 4398.1 4361.0 4390.0 4391.9 4432.4 4469.0 4147.5 4246.8 4296.9 4360.0 4380.3 4080.8 4240.8 4246.2 4307.9 4331.9 4276.1 4279.6 4315.0 4402.0 4424.0 4506.4 4562.4 4608.8 4689.2 4702.5 4911.6 4937.9 4989.6 5056.2 5086.4 4991.7 5017.5 5019.3 5050.3 5062.7 4546.4 4579.0 4642.5 4666.0 4706.0 4869.8 5180.6 5190.6 5205.7 5249.4 4841.9 4910.7 4931.5 4939.3 4969.7 4946.2 5077.0 5090.3 5092.8 5099.2 4847.7 4923.6 4944.2 4945.1 4946.7 5028.0 5030.5 5043.0 5083.6 5097.7 3753.6 3768.0 3844.7 3908.6 3939.2 3475.3 3575.9 3609.1 3617.5 3617.9 4640.7 4712.6 4745.7 4760.2 4769.2 5040.9 5043.7 5046.7 5050.4 5173.0 4624.8 4636.9 4763.8 4767.7 4775.1 4489.4 4508.5 4523.9 4531.4 4555.5 5165.6 5167.4 5168.9 5243.1 5246.5 4915.3 4934.9 5050.8 5055.7 5132.4 5086.3 5144.8 5161.8 5165.8 5182.7 5027.2 5028.3 5030.5 5072.5 5085.4 4899.1 4969.4 5015.1 5023.6 5091.2 4935.6 4945.5 4978.8 5023.6 5127.8 4822.3 4913.7 4929.7 4932.5 5005.7 4683.8 4724.8 4859.6 4919.0 5032.7 4953.0 4960.9 5009.4 5013.4 5047.7 4907.8 4954.4 4981.1 4981.9 5005.9 05:50:19 INFO - 2015-11-05 05:50:19,797 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,797 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45101.87 Median:33940.32 stddev:77003.25 (226.9%) stddev-sans-first:77146.39 05:50:19 INFO - 2015-11-05 05:50:19,798 DEBUG : BROWSER_OUTPUT: Values: 484.6 488.8 500.1 512.6 517.0 27960.7 28643.1 33928.7 34672.8 34717.7 37542.0 37706.8 37774.2 37946.4 38047.4 7470.8 8360.1 8420.9 8441.7 8543.3 7517.7 9856.5 10080.0 10158.8 10189.1 9899.8 9998.9 10048.9 10070.5 10100.0 7605.6 7624.7 9763.8 9932.0 9994.4 9792.2 9813.9 9857.8 9874.7 9936.2 36435.3 36918.3 37209.6 37443.6 37497.0 2646.8 2701.7 2759.3 2842.5 3181.4 24986.0 25028.0 25073.9 25134.0 25495.2 2180.7 2196.8 2209.8 2217.1 2218.3 258720.0 262690.0 262742.0 262789.0 263372.0 55940.0 56082.7 56194.0 57082.4 57084.0 55552.7 56664.4 65511.3 66842.0 67692.7 13366.3 13409.2 13537.4 13677.5 13752.2 10091.0 10157.1 10158.8 10159.4 10172.5 18554.4 18770.8 18775.2 18806.0 18943.2 7755.0 7956.4 8001.0 8002.4 8048.3 796.0 843.4 863.0 863.1 969.2 25580.9 25752.0 25816.7 25823.7 26003.0 945.5 970.3 995.5 1022.8 1095.1 13425.2 13473.8 13553.8 13630.7 13634.3 344937.0 350401.0 350578.0 351393.0 351932.0 53747.5 53822.0 54601.5 54621.5 54959.0 1212.4 1218.4 1218.7 1220.5 1223.4 25527.6 25937.2 26004.5 26018.0 26114.5 42804.1 42871.0 43084.8 43108.6 43309.0 255953.4 259632.0 259898.0 260623.0 261415.0 30012.8 41861.8 42533.6 42741.4 42790.6 38822.8 39872.4 40340.6 40438.0 40677.2 33417.5 33707.8 33933.5 34031.8 34249.7 28336.3 32415.4 33947.2 36593.6 37201.3 33331.3 33430.2 33662.8 33926.8 33980.0 27342.9 28503.7 29210.0 29217.3 29387.6 20949.8 23099.8 23230.5 23434.6 24036.8 05:50:19 INFO - 2015-11-05 05:50:19,798 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,798 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24222.64 Median:452.71 stddev:82008.88 (18115.2%) stddev-sans-first:82219.25 05:50:19 INFO - 2015-11-05 05:50:19,799 DEBUG : BROWSER_OUTPUT: Values: 290.3 291.8 295.6 299.1 299.6 12842.0 13260.1 15557.0 16275.4 16691.7 13305.8 15364.9 15544.3 15973.8 15982.8 4132.9 4268.6 4280.1 4781.3 4951.4 2995.0 3103.0 4197.1 4251.1 4306.3 4202.8 4232.8 4256.8 4259.2 4269.7 4157.3 4251.9 4254.9 4255.2 4274.3 3561.8 3577.7 3580.3 3587.3 3591.0 11145.4 11425.2 11623.8 11634.1 11946.6 1604.6 1657.4 1701.5 1712.9 1795.9 8321.5 8360.7 8522.4 8570.1 8574.7 1402.2 1412.5 1412.7 1439.3 1459.1 47018.8 48018.3 48315.8 48472.5 49287.0 5598.3 5625.1 5626.4 5686.0 5721.0 6379.7 6383.7 6433.4 6447.1 6453.9 4590.8 4632.7 4656.0 4661.4 4706.8 4892.8 4902.6 4990.9 5002.0 5026.8 2538.0 2547.4 2553.9 2557.8 2571.9 887.0 888.0 896.4 900.2 954.7 334.4 342.9 371.7 371.7 408.9 9589.7 10243.9 10566.8 10604.6 10719.7 337.7 389.9 389.9 409.2 410.2 5316.5 5428.2 5455.2 5482.8 5521.6 488813.0 493026.0 497392.0 510819.0 512702.0 66644.0 67626.7 67631.7 67777.0 69406.7 445.8 447.6 448.6 451.9 453.5 9370.0 9412.5 9425.7 9635.0 9674.0 29375.4 30604.1 30727.4 31165.4 31190.4 41829.0 42269.2 42412.0 42601.8 42605.6 5251.0 5370.2 5433.2 5444.1 5461.0 10356.9 10462.5 10542.1 10592.3 10626.6 8506.1 8997.5 9115.8 9203.8 9270.7 8782.7 8784.3 8814.8 8822.0 8942.6 8880.2 9219.9 9270.8 9304.6 9363.2 4853.9 4912.4 4917.9 5335.0 5362.9 8539.0 8810.9 8965.9 9028.6 9049.9 05:50:19 INFO - 2015-11-05 05:50:19,799 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,799 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4628.01 Median:5900.87 stddev:2323.23 (39.4%) stddev-sans-first:2315.31 05:50:19 INFO - 2015-11-05 05:50:19,801 DEBUG : BROWSER_OUTPUT: Values: 1183.0 1567.9 1608.9 1656.2 1666.2 6040.1 6213.1 6509.8 6626.5 6638.7 6549.8 6658.1 6667.8 6689.2 6734.9 1913.6 1915.4 1916.0 1940.6 1941.0 1956.1 1961.3 1975.7 1985.6 2019.2 1943.3 1946.1 1958.3 1963.2 1963.9 1833.9 1867.7 1877.0 1885.1 1892.9 1915.7 1944.2 1953.7 1961.1 1973.6 6019.1 6565.8 6642.5 6658.2 6715.0 3734.8 4006.9 4095.1 4116.2 4127.5 2403.4 2499.6 2546.3 2567.9 2573.5 746.0 746.6 760.0 779.7 782.6 8500.7 8520.7 8546.7 8586.5 8590.4 3650.5 3680.4 3709.8 3715.9 3764.7 7523.5 7607.7 7612.3 7630.5 7639.9 4172.4 4189.8 4204.7 4208.9 4219.9 3813.4 3843.1 3847.8 3848.0 3848.4 3028.2 3040.5 3074.1 3113.6 3126.1 955.5 958.5 965.1 967.8 969.2 945.7 982.8 1148.1 1178.8 1193.7 6303.3 6316.7 6319.7 6387.7 6433.6 1027.2 1028.3 1044.2 1048.4 1064.8 5045.1 5077.1 5079.6 5084.0 5116.5 7109.5 7310.6 7398.2 7726.4 7760.8 7607.5 7621.7 7636.6 7663.2 7677.4 6088.0 6224.4 6250.6 6289.9 6293.9 6200.4 6225.8 6250.4 6254.3 6258.8 6901.8 6981.8 7013.1 7033.8 7041.9 7005.6 7143.4 7184.5 7291.2 7295.9 5664.9 5721.7 5740.8 5752.8 5772.9 6380.8 6401.7 6445.5 6458.6 6509.6 5811.9 6011.3 6050.7 6160.5 6161.3 5852.9 5892.1 5909.6 5960.5 5971.9 5978.5 5998.5 6021.2 6024.0 6054.2 5414.8 5492.5 5506.2 5537.6 5537.9 5566.6 5588.3 5630.6 5655.8 5661.2 05:50:19 INFO - 2015-11-05 05:50:19,801 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,801 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4768.52 Median:5530.67 stddev:1450.61 (26.2%) stddev-sans-first:1414.94 05:50:19 INFO - 2015-11-05 05:50:19,801 DEBUG : BROWSER_OUTPUT: Values: 275.3 275.4 279.4 282.1 283.9 5349.4 5397.1 5444.3 5486.5 5493.7 5330.8 5371.2 5397.1 5422.3 5426.5 4150.1 4156.0 4157.8 4177.2 4187.4 3986.1 4058.9 4112.2 4125.8 4149.0 4097.4 4098.2 4128.2 4135.5 4140.6 4084.9 4092.4 4111.3 4120.9 4154.0 3519.6 3547.2 3558.5 3560.8 3574.1 5177.7 5246.8 5252.6 5259.8 5280.5 4676.5 4687.7 4696.5 4701.2 4708.4 5623.8 5644.9 5690.0 5708.4 5710.5 3857.9 3871.6 3888.6 3890.0 3896.6 5612.5 5764.3 5803.1 5899.6 5909.1 3883.5 3886.5 3901.1 3915.5 3958.4 3959.4 3996.6 4012.9 4019.3 4019.3 4598.5 4635.2 4636.4 4648.6 4652.9 5578.1 5738.5 5759.7 5781.1 5782.4 1434.6 1437.2 1444.4 1459.9 1460.2 924.2 927.1 938.6 938.8 945.8 5492.1 5513.4 5530.0 5548.7 5554.6 5964.1 5970.1 5976.9 5983.6 6004.5 5470.3 5514.8 5526.8 5531.3 5556.1 3181.5 3247.5 3256.6 3265.6 3294.0 5959.5 5980.6 6005.6 6016.6 6074.7 6084.3 6113.0 6115.8 6129.1 6146.5 5836.5 5993.9 6013.0 6028.0 6035.8 5937.7 5951.3 5967.6 5979.1 5985.6 5776.5 5781.2 5836.2 5853.6 5857.7 5835.8 5846.7 5907.1 5950.8 6001.5 3827.7 3940.7 3942.2 3976.4 3984.6 5862.9 5868.7 5877.6 5913.5 5929.3 5608.0 5714.3 5757.1 5776.1 5801.1 5732.9 5734.2 5775.6 5829.8 5868.5 5583.1 5598.4 5638.7 5656.6 5696.3 5753.2 5755.2 5829.3 5838.0 5847.7 5589.2 5697.0 5747.3 5764.4 5802.6 05:50:19 INFO - 2015-11-05 05:50:19,801 DEBUG : BROWSER_OUTPUT: 05:50:19 INFO - 2015-11-05 05:50:19,803 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12082.40 Median:5806.37 stddev:15103.40 (260.1%) stddev-sans-first:15121.50 05:50:19 INFO - 2015-11-05 05:50:19,804 DEBUG : BROWSER_OUTPUT: Values: 681.1 700.7 704.3 718.8 742.3 12691.4 12704.4 12807.2 12838.7 12932.5 11949.9 12041.9 12167.7 12169.0 12180.9 642.8 663.5 816.1 830.7 837.6 822.1 826.0 829.9 840.3 840.3 862.5 869.6 880.3 882.0 882.0 640.6 678.4 821.5 842.3 850.0 626.2 626.2 626.5 627.2 631.2 11845.5 12011.3 12032.6 12130.9 12212.8 10482.7 10661.8 10797.4 10814.7 10990.7 8279.4 8370.9 8552.3 8557.1 8809.7 2572.2 2752.5 2950.9 3042.5 3073.1 40062.4 42707.0 42798.1 43003.8 43159.0 5813.9 5815.1 5826.4 5888.3 5986.0 10457.5 10562.5 10568.7 10591.8 10676.9 5549.3 5587.8 5718.6 5759.5 5798.8 3430.3 3444.7 3503.2 3545.6 3578.8 2233.9 2274.5 2280.2 2290.3 2291.0 341.9 349.7 353.4 354.0 354.3 412.1 444.4 446.8 470.1 508.9 6669.3 7029.9 7077.6 7178.7 7318.9 429.5 449.8 534.7 563.5 566.5 3184.5 3224.8 3394.7 3538.6 3546.2 57804.7 58316.0 58331.7 58499.4 59262.4 45899.3 46708.0 47796.8 48216.3 48544.3 41915.6 42255.8 42393.6 43108.4 44085.1 7326.8 7359.6 7370.9 7401.8 7464.2 31135.7 31594.2 31804.2 32306.4 32669.3 37141.3 37807.2 38935.6 42594.0 43110.0 6627.9 6893.3 6947.7 6964.0 7043.1 9419.4 9564.6 9580.6 9680.1 9704.4 9484.4 9605.2 9687.1 9793.6 9849.0 9449.6 9684.6 9723.6 9728.7 9729.9 9144.7 9394.8 9405.4 9424.7 9555.2 8075.3 8086.6 8127.3 8404.5 8540.8 7956.9 7975.0 8042.6 8070.8 8093.9 05:50:19 INFO - 2015-11-05 05:50:19,804 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:19 INFO - 2015-11-05 05:50:19,804 DEBUG : BROWSER_OUTPUT: 05:50:20 INFO - 2015-11-05 05:50:20,472 INFO : Browser exited with error code: 0 05:50:20 INFO - 2015-11-05 05:50:20,502 INFO : Completed test dromaeo_css (00:18:35) 05:50:20 INFO - 2015-11-05 05:50:20,503 INFO : Starting test kraken 05:50:20 INFO - 2015-11-05 05:50:20,503 DEBUG : operating with platform_type : mac_ 05:50:20 INFO - 2015-11-05 05:50:20,503 INFO : Initialising browser for kraken test... 05:50:20 INFO - 2015-11-05 05:50:20,518 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/tmpWDpLcq/profile http://localhost:49268/getInfo.html 05:50:22 INFO - 2015-11-05 05:50:22,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:50:22 INFO - 2015-11-05 05:50:22,924 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:50:22 INFO - 2015-11-05 05:50:22,924 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:50:22 INFO - 2015-11-05 05:50:22,924 DEBUG : BROWSER_OUTPUT: __metrics 05:50:22 INFO - 2015-11-05 05:50:22,940 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:23 INFO - 2015-11-05 05:50:23,662 INFO : Browser initialized. 05:50:23 INFO - 2015-11-05 05:50:23,663 INFO : Running cycle 1/1 for kraken test... 05:50:23 INFO - 2015-11-05 05:50:23,663 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/tmpWDpLcq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:50:35 INFO - 2015-11-05 05:50:35,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 221921280 05:50:35 INFO - 2015-11-05 05:50:35,655 DEBUG : BROWSER_OUTPUT: 05:50:38 INFO - 2015-11-05 05:50:38,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:38 INFO - 2015-11-05 05:50:38,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 277442560 05:50:38 INFO - 2015-11-05 05:50:38,843 DEBUG : BROWSER_OUTPUT: 05:50:41 INFO - 2015-11-05 05:50:41,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 05:50:42 INFO - 2015-11-05 05:50:42,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 290586624 05:50:42 INFO - 2015-11-05 05:50:42,365 DEBUG : BROWSER_OUTPUT: 05:50:45 INFO - 2015-11-05 05:50:45,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 05:50:46 INFO - 2015-11-05 05:50:46,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 274849792 05:50:46 INFO - 2015-11-05 05:50:46,166 DEBUG : BROWSER_OUTPUT: 05:50:48 INFO - 2015-11-05 05:50:48,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 05:50:48 INFO - 2015-11-05 05:50:48,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 276606976 05:50:48 INFO - 2015-11-05 05:50:48,910 DEBUG : BROWSER_OUTPUT: 05:50:51 INFO - 2015-11-05 05:50:51,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:51 INFO - 2015-11-05 05:50:51,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 275869696 05:50:51 INFO - 2015-11-05 05:50:51,817 DEBUG : BROWSER_OUTPUT: 05:50:55 INFO - 2015-11-05 05:50:55,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:55 INFO - 2015-11-05 05:50:55,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 277037056 05:50:55 INFO - 2015-11-05 05:50:55,733 DEBUG : BROWSER_OUTPUT: 05:50:59 INFO - 2015-11-05 05:50:59,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:59 INFO - 2015-11-05 05:50:59,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 276197376 05:50:59 INFO - 2015-11-05 05:50:59,718 DEBUG : BROWSER_OUTPUT: 05:51:02 INFO - 2015-11-05 05:51:02,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 05:51:03 INFO - 2015-11-05 05:51:03,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 276508672 05:51:03 INFO - 2015-11-05 05:51:03,450 DEBUG : BROWSER_OUTPUT: 05:51:05 INFO - 2015-11-05 05:51:05,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:05 INFO - 2015-11-05 05:51:05,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 312938496 05:51:05 INFO - 2015-11-05 05:51:05,663 DEBUG : BROWSER_OUTPUT: 05:51:07 INFO - 2015-11-05 05:51:07,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:08 INFO - 2015-11-05 05:51:08,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 312430592 05:51:08 INFO - 2015-11-05 05:51:08,196 DEBUG : BROWSER_OUTPUT: 05:51:10 INFO - 2015-11-05 05:51:10,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:11 INFO - 2015-11-05 05:51:11,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 319873024 05:51:11 INFO - 2015-11-05 05:51:11,024 DEBUG : BROWSER_OUTPUT: 05:51:13 INFO - 2015-11-05 05:51:13,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:14 INFO - 2015-11-05 05:51:14,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 321454080 05:51:14 INFO - 2015-11-05 05:51:14,437 DEBUG : BROWSER_OUTPUT: 05:51:17 INFO - 2015-11-05 05:51:17,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:17 INFO - 2015-11-05 05:51:17,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 320139264 05:51:17 INFO - 2015-11-05 05:51:17,820 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 05:51:19 INFO - 2015-11-05 05:51:19,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 380768256 05:51:19 INFO - 2015-11-05 05:51:19,931 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,931 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;103;109;110;113;108;110;110;113 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;142;178;190;156;168;166;175;202;148 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;181;180;181;201;183;181;187;184;182 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;86;97;98;82;80;83;90;95;75 05:51:19 INFO - 2015-11-05 05:51:19,932 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;107;151;99;105;103;150;100;99;148 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;124;135;140;136;129;136;136;136;129;135 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;140;141;141;142;148;144;141;140;142;140 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;112;116;118;118;117;114;113;118;115 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;60;63;68;66;67;74;65;65 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;73;75;77;77;76;76;76;76 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;96;97;99;101;101;100;97;98;96 05:51:19 INFO - 2015-11-05 05:51:19,933 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;145;148;145;153;142;156;152;145;146 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;168;170;172;177;166;169;168;168;173 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;74;77;78;80;78;82;82;85;82 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,919 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: __startTimestamp1446731479929__endTimestamp 05:51:19 INFO - 2015-11-05 05:51:19,934 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,935 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:51:19 INFO - 2015-11-05 05:51:19,935 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:51:19 INFO - 2015-11-05 05:51:19,935 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,935 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.86 (2.6%) stddev-sans-first:3.00 05:51:19 INFO - 2015-11-05 05:51:19,936 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 103.0 109.0 110.0 113.0 108.0 110.0 110.0 113.0 05:51:19 INFO - 2015-11-05 05:51:19,936 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:168.30 Median:171.50 stddev:18.60 (10.8%) stddev-sans-first:19.35 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: Values: 158.0 142.0 178.0 190.0 156.0 168.0 166.0 175.0 202.0 148.0 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.20 Median:182.50 stddev:7.33 (4.0%) stddev-sans-first:6.56 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: Values: 172.0 181.0 180.0 181.0 201.0 183.0 181.0 187.0 184.0 182.0 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.20 Median:88.00 stddev:8.46 (9.6%) stddev-sans-first:8.12 05:51:19 INFO - 2015-11-05 05:51:19,937 DEBUG : BROWSER_OUTPUT: Values: 76.0 86.0 97.0 98.0 82.0 80.0 83.0 90.0 95.0 75.0 05:51:19 INFO - 2015-11-05 05:51:19,938 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,938 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:116.10 Median:150.50 stddev:23.33 (15.5%) stddev-sans-first:23.91 05:51:19 INFO - 2015-11-05 05:51:19,938 DEBUG : BROWSER_OUTPUT: Values: 99.0 107.0 151.0 99.0 105.0 103.0 150.0 100.0 99.0 148.0 05:51:19 INFO - 2015-11-05 05:51:19,938 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,938 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.60 Median:136.00 stddev:4.74 (3.5%) stddev-sans-first:3.54 05:51:19 INFO - 2015-11-05 05:51:19,938 DEBUG : BROWSER_OUTPUT: Values: 124.0 135.0 140.0 136.0 129.0 136.0 136.0 136.0 129.0 135.0 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:141.90 Median:141.50 stddev:2.47 (1.7%) stddev-sans-first:2.52 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: Values: 140.0 141.0 141.0 142.0 148.0 144.0 141.0 140.0 142.0 140.0 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:115.50 Median:116.50 stddev:2.22 (1.9%) stddev-sans-first:2.29 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: Values: 114.0 112.0 116.0 118.0 118.0 117.0 114.0 113.0 118.0 115.0 05:51:19 INFO - 2015-11-05 05:51:19,939 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,940 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.50 stddev:4.79 (7.3%) stddev-sans-first:4.65 05:51:19 INFO - 2015-11-05 05:51:19,940 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 60.0 63.0 68.0 66.0 67.0 74.0 65.0 65.0 05:51:19 INFO - 2015-11-05 05:51:19,940 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,940 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.10 Median:76.00 stddev:3.67 (4.8%) stddev-sans-first:2.85 05:51:19 INFO - 2015-11-05 05:51:19,940 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 73.0 75.0 77.0 77.0 76.0 76.0 76.0 76.0 05:51:19 INFO - 2015-11-05 05:51:19,941 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:96.50 stddev:3.77 (3.9%) stddev-sans-first:2.00 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: Values: 88.0 96.0 97.0 99.0 101.0 101.0 100.0 97.0 98.0 96.0 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:147.00 stddev:5.59 (3.8%) stddev-sans-first:4.64 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: Values: 137.0 145.0 148.0 145.0 153.0 142.0 156.0 152.0 145.0 146.0 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,942 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:169.50 stddev:8.26 (4.9%) stddev-sans-first:3.37 05:51:19 INFO - 2015-11-05 05:51:19,943 DEBUG : BROWSER_OUTPUT: Values: 146.0 168.0 170.0 172.0 177.0 166.0 169.0 168.0 168.0 173.0 05:51:19 INFO - 2015-11-05 05:51:19,943 DEBUG : BROWSER_OUTPUT: 05:51:19 INFO - 2015-11-05 05:51:19,943 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.90 Median:81.00 stddev:4.20 (5.2%) stddev-sans-first:3.35 05:51:19 INFO - 2015-11-05 05:51:19,943 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 77.0 78.0 80.0 78.0 82.0 82.0 85.0 82.0 05:51:19 INFO - 2015-11-05 05:51:19,943 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:51:19 INFO - 2015-11-05 05:51:19,943 DEBUG : BROWSER_OUTPUT: 05:51:20 INFO - 2015-11-05 05:51:20,671 INFO : Browser exited with error code: 0 05:51:20 INFO - 2015-11-05 05:51:20,723 INFO : Completed test kraken (00:01:00) 05:51:20 INFO - 2015-11-05 05:51:20,723 INFO : Starting test v8_7 05:51:20 INFO - 2015-11-05 05:51:20,723 DEBUG : operating with platform_type : mac_ 05:51:20 INFO - 2015-11-05 05:51:20,724 INFO : Initialising browser for v8_7 test... 05:51:20 INFO - 2015-11-05 05:51:20,736 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/tmpDer_Tu/profile http://localhost:49268/getInfo.html 05:51:23 INFO - 2015-11-05 05:51:23,072 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:51:23 INFO - 2015-11-05 05:51:23,072 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:51:23 INFO - 2015-11-05 05:51:23,072 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:51:23 INFO - 2015-11-05 05:51:23,073 DEBUG : BROWSER_OUTPUT: __metrics 05:51:23 INFO - 2015-11-05 05:51:23,080 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:23 INFO - 2015-11-05 05:51:23,791 INFO : Browser initialized. 05:51:23 INFO - 2015-11-05 05:51:23,791 INFO : Running cycle 1/1 for v8_7 test... 05:51:23 INFO - 2015-11-05 05:51:23,791 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/T/tmpDer_Tu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:51:35 INFO - 2015-11-05 05:51:35,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 220569600 05:51:35 INFO - 2015-11-05 05:51:35,761 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 691081216 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |0;Richards;169.89466530750934 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;225.07314877335133 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |2;Encrypt;354.10764872521247 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6262.5 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2308.7557603686637 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |5;Earley;998.003992015968 05:51:58 INFO - 2015-11-05 05:51:58,886 DEBUG : BROWSER_OUTPUT: |6;Boyer;14400 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: |7;RegExp;32774.1935483871 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: |8;Splay;881.0572687224669 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6394.904458598726 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: __startTimestamp1446731518884__endTimestamp 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.89 Median:169.89 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: Values: 169.9 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:225.07 Median:225.07 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: Values: 225.1 05:51:58 INFO - 2015-11-05 05:51:58,887 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:354.11 Median:354.11 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: Values: 354.1 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6262.50 Median:6262.50 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: Values: 6262.5 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2308.76 Median:2308.76 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: Values: 2308.8 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:998.00 Median:998.00 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: Values: 998.0 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14400.00 Median:14400.00 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,888 DEBUG : BROWSER_OUTPUT: Values: 14400.0 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32774.19 Median:32774.19 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: Values: 32774.2 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:881.06 Median:881.06 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: Values: 881.1 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6394.90 Median:6394.90 stddev:0.00 (0.0%) 05:51:58 INFO - 2015-11-05 05:51:58,889 DEBUG : BROWSER_OUTPUT: Values: 6394.9 05:51:58 INFO - 2015-11-05 05:51:58,890 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:51:58 INFO - 2015-11-05 05:51:58,890 DEBUG : BROWSER_OUTPUT: 05:51:59 INFO - 2015-11-05 05:51:59,593 INFO : Browser exited with error code: 0 05:51:59 INFO - 2015-11-05 05:51:59,615 INFO : Completed test v8_7 (00:00:38) 05:51:59 INFO - 2015-11-05 05:51:59,656 INFO : Completed test suite (00:20:14) 05:51:59 INFO - 2015-11-05 05:51:59,656 DEBUG : Working with test: dromaeo_css 05:51:59 INFO - 2015-11-05 05:51:59,656 DEBUG : Generating results file: dromaeo_css 05:51:59 INFO - 2015-11-05 05:51:59,658 DEBUG : Working with test: kraken 05:51:59 INFO - 2015-11-05 05:51:59,658 DEBUG : Generating results file: kraken 05:51:59 INFO - 2015-11-05 05:51:59,658 INFO : javascript benchmark 05:51:59 INFO - 2015-11-05 05:51:59,658 DEBUG : Working with test: v8_7 05:51:59 INFO - 2015-11-05 05:51:59,658 DEBUG : Generating results file: v8_7 05:51:59 INFO - 2015-11-05 05:51:59,658 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:59 INFO - 2015-11-05 05:51:59,714 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:51:59 INFO - 2015-11-05 05:51:59,714 DEBUG : process_Request line: dromaeo_css 5872.23 graph.html#tests=[[72,1,55]] 05:51:59 INFO - 2015-11-05 05:51:59,714 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:59 INFO - 2015-11-05 05:51:59,746 DEBUG : process_Request line: kraken 1683.40 graph.html#tests=[[232,1,55]] 05:51:59 INFO - 2015-11-05 05:51:59,746 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:59 INFO - 2015-11-05 05:51:59,785 DEBUG : process_Request line: v8_7 16152.07 graph.html#tests=[[230,1,55]] 05:51:59 INFO - 2015-11-05 05:51:59,786 INFO : javascript benchmark 05:51:59 INFO - 2015-11-05 05:51:59,788 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [290.31196065325184, 291.7578409919767, 295.5994627280036, 299.0669112369407, 299.5641341847613, 12842.0, 13260.138091024077, 15557.0, 16275.430359937405, 16691.666166676674, 13305.800412993813, 15364.923175384136, 15544.300506477208, 15973.840261597381, 15982.84017159831, 4132.938005929914, 4268.551802060785, 4280.122574872144, 4781.258904869751, 4951.405831300249, 2995.0415866922594, 3103.0070377479215, 4197.07664313852, 4251.06476575153, 4306.332518459643, 4202.810873510684, 4232.830686772525, 4256.808443620044, 4259.212045771542, 4269.658427325807, 4157.334826427757, 4251.87244382669, 4254.91490170198, 4255.17024180285, 4274.316109422493, 3561.821908904544, 3577.713782897362, 3580.3018411409785, 3587.336342776595, 3591.0124715703128, 11145.387003714792, 11425.200235983484, 11623.825642615368, 11634.127440441916, 11946.581869634609, 1604.5908293385228, 1657.3784830688492, 1701.5235733994377, 1712.940047098358, 1795.9102044897702, 8321.500709957361, 8360.665573377057, 8522.40343175978, 8570.142985701443, 8574.657013719443, 1402.249796358943, 1412.4844431782326, 1412.7245187188503, 1439.2731670506432, 1459.109942934809, 47018.764906175595, 48018.27972580414, 48315.75842120802, 48472.51527484715, 49287.0, 5598.3282006159525, 5625.059354522683, 5626.437356264422, 5686.0, 5720.971395143081, 6379.681015949184, 6383.744650214032, 6433.420992110732, 6447.097406363113, 6453.9351007083305, 4590.816367345269, 4632.72203667781, 4655.953440465552, 4661.394018777537, 4706.835260765925, 4892.779824907888, 4902.607791376681, 4990.850274491771, 5002.0, 5026.824061157842, 2538.0, 2547.4013606802387, 2553.936151596225, 2557.820952533305, 2571.8555242916723, 886.9512176830336, 888.0, 896.3904544909394, 900.2482926756232, 954.7326748510428, 334.35135836477156, 342.9279851231269, 371.6766413220515, 371.68035489479024, 408.9468369112056, 9589.664361747446, 10243.897561024294, 10566.788664226826, 10604.575816967235, 10719.713634363927, 337.73319077928653, 389.9064224586079, 389.91811719539214, 409.22451953548455, 410.2287699125625, 5316.548093412026, 5428.158635411518, 5455.18172274162, 5482.753276102585, 5521.558275337963, 488813.0, 493026.0, 497392.0, 510819.0, 512702.0, 66644.0, 67626.66186669134, 67631.66184169146, 67777.0, 69406.65296673484, 445.7815670321584, 447.59045473391484, 448.60746846509306, 451.87799294190387, 453.53739186030066, 9369.953150234205, 9412.529373531434, 9425.717228483156, 9635.0, 9673.951630241803, 29375.412491750474, 30604.08187754371, 30727.385452291277, 31165.376692466478, 31190.37619247557, 41829.0, 42269.154616906875, 42412.0, 42601.786991064844, 42605.5739442614, 5251.0, 5370.2213179089595, 5433.239346491573, 5444.074507333842, 5461.0, 10356.948215258875, 10462.529186186488, 10542.051215390651, 10592.311499752492, 10626.574937002742, 8506.149385061444, 8997.460152390877, 9115.817683646157, 9203.76990575241, 9270.72187834366, 8782.736517904474, 8784.253338466302, 8814.823703526023, 8821.955890220508, 8942.642294308154, 8880.245179159843, 9219.907800922174, 9270.768230794283, 9304.627814887599, 9363.157315841607, 4853.927191092207, 4912.361393018885, 4917.9016419672125, 5335.0, 5362.919556206738, 8539.0, 8810.911890881265, 8965.865007763658, 9028.638854446011, 9049.864252036094], "dojo.html": [2816.7324104210106, 2839.971600283999, 2873.7269959353853, 2889.566565015246, 3117.7349925256353, 4631.421072365954, 4713.457952335482, 4721.811127554898, 4721.952780472194, 4746.145693775119, 4636.165490211761, 4670.766461676911, 4672.6261899047995, 4701.083288758693, 4716.174669432844, 4293.334533147367, 4306.160298741746, 4320.28715261983, 4366.061296821183, 4398.098389830077, 4361.040571074359, 4390.034192477649, 4391.890202744925, 4432.3573081903105, 4469.0, 4147.502299724022, 4246.808893599765, 4296.935545966813, 4360.040791025969, 4380.321050237202, 4080.8163632636306, 4240.830366785356, 4246.2356775780345, 4307.91384172318, 4331.913361732779, 4276.144771045772, 4279.614834664895, 4314.9784251078545, 4401.955980440187, 4424.048829501673, 4506.414166158411, 4562.384078149441, 4608.769561521911, 4689.249720044811, 4702.4827269000725, 4911.631627627907, 4937.901241975141, 4989.57588604969, 5056.241563765465, 5086.364204474441, 4991.725455099968, 5017.523335283142, 5019.297298378194, 5050.343455350818, 5062.721550314731, 4546.408966834357, 4579.038401935631, 4642.46611639659, 4666.020135771492, 4705.95294047062, 4869.756512174377, 5180.585553155738, 5190.6107041972, 5205.7397130143345, 5249.42256351801, 4841.8547443576745, 4910.705357678551, 4931.457539670633, 4939.3084968104495, 4969.652124351333, 4946.159152944008, 5077.0, 5090.312807770978, 5092.770825312869, 5099.235114732745, 4847.684900481458, 4923.630727695438, 4944.233643785219, 4945.134601444733, 4946.727929963815, 5027.974860125676, 5030.496950305013, 5043.041822053798, 5083.567896728746, 5097.668651537638, 3753.6246375362794, 3767.9811600942367, 3844.692424606025, 3908.5700572936953, 3939.212157568498, 3475.304939012208, 3575.8927232183078, 3609.115766637138, 3617.5297211362354, 3617.94573081404, 4640.698354607007, 4712.5758681718125, 4745.715257084586, 4760.238361862085, 4769.2369220925175, 5040.899182016413, 5043.722595257223, 5046.6719663221775, 5050.444451110375, 5173.042987047408, 4624.791884365144, 4636.884077898012, 4763.809447622126, 4767.73777442244, 4775.068861572029, 4489.416375871116, 4508.549145085465, 4523.88690282739, 4531.410916580823, 4555.498895121534, 5165.560927321145, 5167.405748338989, 5168.922466162935, 5243.10867152585, 5246.475352464876, 4915.287283343967, 4934.901301973869, 5050.797968081236, 5055.6713813602, 5132.409772876018, 5086.338775959101, 5144.819931302536, 5161.7677204525135, 5165.767540460613, 5182.663126896739, 5027.170516864822, 5028.296038554532, 5030.547250747451, 5072.467390924047, 5085.4406015337545, 4899.1426500363, 4969.35398398206, 5015.072211640858, 5023.598112151092, 5091.236314552847, 4935.580475659609, 4945.530174633404, 4978.800847966041, 5023.57299629521, 5127.769250383667, 4822.252550854623, 4913.70517768935, 4929.679570827885, 4932.506749325039, 5005.674631148963, 4683.765811709469, 4724.763761811827, 4859.586935110555, 4918.950810491992, 5032.748362581783, 4953.0, 4960.8759781005765, 5009.423916249678, 5013.39839219296, 5047.697138171721, 4907.754612269444, 4954.355933728592, 4981.103401387785, 4981.900361992813, 5005.874853128701], "mootools.html": [1182.9881701182985, 1567.8902476826622, 1608.9034657920517, 1656.1719140429784, 1666.191896929989, 6040.063790112534, 6213.068039794033, 6509.837254068645, 6626.5030122740745, 6638.668066596675, 6549.77075802347, 6658.134442522465, 6667.833304167386, 6689.193917642234, 6734.865302693943, 1913.5981443896728, 1915.3870761356372, 1915.9616807663838, 1940.602176553803, 1940.9514762130918, 1956.1295223625493, 1961.2743284984576, 1975.733276007735, 1985.553250518629, 2019.162047750182, 1943.2906988949073, 1946.124244090158, 1958.3243780895639, 1963.2245263121058, 1963.9214431422727, 1833.8716289859715, 1867.7198420236937, 1877.0145673521374, 1885.0857334192906, 1892.858035647332, 1915.7413749143827, 1944.202876820511, 1953.7460130182985, 1961.0586918279305, 1973.5559499112728, 6019.127226552169, 6565.770198043093, 6642.468602511787, 6658.234303055162, 6714.966425167843, 3734.7572407793405, 4006.8597599084183, 4095.058136628592, 4116.197341518405, 4127.463429754142, 2403.399150212447, 2499.5875680512695, 2546.315920708141, 2567.9101231457, 2573.4595734895693, 745.9589722565257, 746.6304179431216, 759.9506032107895, 779.6569509415896, 782.5617654113714, 8500.659973601048, 8520.659173633047, 8546.743597692079, 8586.527740974245, 8590.355723320776, 3650.4889315495852, 3680.392735198662, 3709.8145092745253, 3715.888523344304, 3764.7176461765475, 7523.473356865076, 7607.695692172251, 7612.3148916596665, 7630.542167469858, 7639.923600763921, 4172.4144824966315, 4189.769562674082, 4204.726692764961, 4208.91582168361, 4219.852305169305, 3813.447050177764, 3843.135294558758, 3847.826847791856, 3847.9807600962376, 3848.3842585186794, 3028.227801910499, 3040.467918114321, 3074.0624109646774, 3113.610798650169, 3126.0621813455873, 955.4649396338073, 958.5159494455255, 965.0831709875506, 967.7967626798451, 969.1665167955553, 945.7021038373028, 982.8034393121404, 1148.0987424871603, 1178.7878181927335, 1193.7493126443544, 6303.338149494329, 6316.684165791692, 6319.747210111544, 6387.744490220339, 6433.646149461731, 1027.2347101409498, 1028.2956175019985, 1044.154235069596, 1048.3552615141632, 1064.7710742190466, 5045.091883460939, 5077.086124497552, 5079.619028572872, 5083.974580127149, 5116.513931176532, 7109.537880037781, 7310.634468276565, 7398.223186565441, 7726.420518461138, 7760.767176984699, 7607.505512141693, 7621.695132194761, 7636.579988100597, 7663.19536448676, 7677.385809135256, 6088.0, 6224.439800417984, 6250.593711408744, 6289.8742025159245, 6293.874122517524, 6200.441960223601, 6225.8132256032395, 6250.406211409909, 6254.343293954252, 6258.812235632939, 6901.827454313682, 6981.79054628362, 7013.123359580052, 7033.824154396181, 7041.929580704127, 7005.614691192033, 7143.357097861218, 7184.497085203986, 7291.234420385783, 7295.854082918206, 5664.943350566607, 5721.713914304351, 5740.799072032459, 5752.798652047159, 5772.913406298993, 6380.840478988062, 6401.679916004275, 6445.452136568444, 6458.644774537445, 6509.609423434609, 5811.883762324645, 6011.27864656244, 6050.697465126814, 6160.507159427146, 6161.322254551906, 5852.882942341214, 5892.145638882424, 5909.586328957103, 5960.5231581474245, 5971.91042134377, 5978.521718262442, 5998.520118390606, 6021.2473440819895, 6024.036154215304, 6054.182685337423, 5414.756335964812, 5492.505674489315, 5506.2291279221745, 5537.640053396516, 5537.889242215053, 5566.554675625859, 5588.273524441796, 5630.605857590093, 5655.773769049192, 5661.207430959586], "ext.html": [484.58567924424614, 488.79470622338613, 500.08484473413654, 512.5643203277212, 516.9712272577569, 27960.720392796065, 28643.140705778835, 33928.66071339289, 34672.82663586685, 34717.652823471755, 37542.0, 37706.81146594263, 37774.24451510975, 37946.430803537965, 38047.42928856063, 7470.813229669275, 8360.080391156984, 8420.873686894702, 8441.662333506652, 8543.316534677242, 7517.661705223278, 9856.507174641276, 10080.04239597237, 10158.847617285746, 10189.133923616502, 9899.802003959916, 9998.900010999905, 10048.899511004869, 10070.546825392876, 10100.0, 7605.581693006882, 7624.695012199505, 9763.755906102333, 9931.950340248324, 9994.350367226143, 9792.21662267017, 9813.90186098137, 9857.802843943153, 9874.703758887244, 9936.155426788731, 36435.27129457396, 36918.26163476742, 37209.62790372116, 37443.62556374429, 37497.0, 2646.8411895286345, 2701.716319786414, 2759.2550011496983, 2842.5025620516326, 3181.411438883814, 24986.0, 25028.0, 25073.874630626913, 25134.0, 25495.23514294574, 2180.7274090738656, 2196.8242540596875, 2209.823214142865, 2217.1020736601704, 2218.3455880515285, 258720.0, 262690.0, 262742.0, 262789.0, 263372.0, 55940.0, 56082.71958640181, 56194.0, 57082.429175708545, 57084.0, 55552.72223638856, 56664.43335566674, 65511.34488655148, 66842.0, 67692.66153669299, 13366.26485543285, 13409.195448273134, 13537.390817413043, 13677.452901884013, 13752.243626600433, 10091.0, 10157.085862272432, 10158.796824063478, 10159.44123073238, 10172.491375431198, 18554.44336669902, 18770.84135324428, 18775.248990040247, 18806.0, 18943.24227030931, 7754.961225193951, 7956.443048986631, 8000.959995199987, 8002.3598112150885, 8048.315893149148, 795.9562224077731, 843.3548335523329, 862.9946112778669, 863.0765081363007, 969.1762002297991, 25580.863565413594, 25752.0, 25816.74183258181, 25823.741762582133, 26003.0, 945.5177859291811, 970.2529052629436, 995.4525011243787, 1022.754538910656, 1095.052779345876, 13425.194488330731, 13473.797893031613, 13553.818100067483, 13630.727385452235, 13634.318284085755, 344937.0, 350401.0, 350578.0, 351393.0, 351932.0, 53747.46252537503, 53822.0, 54601.45398546043, 54621.453785461636, 54959.0, 1212.4119801896074, 1218.3908045977012, 1218.7440637466054, 1220.5422966387605, 1223.3638507975982, 25527.6170857441, 25937.22188334353, 26004.479910401307, 26018.0, 26114.477710446066, 42804.077531084324, 42871.0, 43084.78457607692, 43108.568914310454, 43309.0, 255953.36303140238, 259632.0, 259898.0, 260623.0, 261415.0, 30012.849935750182, 41861.79069104635, 42533.59731221433, 42741.35887961621, 42790.57209427866, 38822.80588597039, 39872.401913971895, 40340.59659403486, 40438.0, 40677.1864562713, 33417.49873751847, 33707.82022629196, 33933.49099763555, 34031.82984085064, 34249.657503425646, 28336.291592710346, 32415.35169296648, 33947.15132121717, 36593.634063659025, 37201.25597488089, 33331.333373332884, 33430.16424589307, 33662.83168584141, 33926.830365848014, 33980.0, 27342.863285683445, 28503.714962850936, 29210.0, 29217.26956826011, 29387.559186612645, 20949.790502094784, 23099.769002310433, 23230.51177660691, 23434.64848027247, 24036.759632403453], "prototype.html": [275.3185864984163, 275.4353575170899, 279.42159729360225, 282.1254112252018, 283.8523967536882, 5349.358077030752, 5397.109476936301, 5444.292242008533, 5486.451354864512, 5493.697846618435, 5330.813421530247, 5371.194320851874, 5397.082495975684, 5422.267993820833, 5426.511613954744, 4150.107726838722, 4155.981784462796, 4157.771322577257, 4177.227212965611, 4187.371894215861, 3986.063275130342, 4058.8985275368204, 4112.239235741397, 4125.7524548527035, 4148.958510414887, 4097.364908439182, 4098.241825262321, 4128.195001974616, 4135.503739551258, 4140.565240649734, 4084.8978775530554, 4092.406601042862, 4111.342185250375, 4120.91758164838, 4154.0030392705685, 3519.6128425873135, 3547.2373439710586, 3558.5018097466377, 3560.839762210681, 3574.1422058705725, 5177.663451875654, 5246.842594722164, 5252.553532949704, 5259.76331065103, 5280.498352656491, 4676.485586585472, 4687.671862969593, 4696.506866778973, 4701.247800351927, 4708.387909571768, 5623.803166889139, 5644.899244647296, 5690.0, 5708.372079071299, 5710.486056254916, 3857.8842634721004, 3871.632194941476, 3888.591697871711, 3890.008047947755, 3896.5713771485116, 5612.466815652507, 5764.279465066867, 5803.129530570406, 5899.646021238739, 5909.143174239754, 3883.514560679915, 3886.5336159660455, 3901.122247494291, 3915.5497117831815, 3958.44581758554, 3959.4456776051375, 3996.600339966038, 4012.879613611596, 4019.256437559061, 4019.296623091006, 4598.471175814824, 4635.188841952645, 4636.374089497875, 4648.604868586208, 4652.883677908079, 5578.0517312057045, 5738.454846789548, 5759.740811663485, 5781.1328300754385, 5782.392848750905, 1434.6126545832567, 1437.1879887863324, 1444.3716983112379, 1459.9051061681168, 1460.218782951116, 924.2282693950626, 927.0960813207204, 938.6104766521817, 938.8075444533854, 945.8108378324363, 5492.093804522209, 5513.393526712059, 5530.0, 5548.72256387179, 5554.583406244547, 5964.135200395918, 5970.0746384310505, 5976.910346344721, 5983.61106528083, 6004.54965877561, 5470.288862447856, 5514.779408823682, 5526.834194974157, 5531.3362396512675, 5556.083246264321, 3181.538676891838, 3247.4641684121857, 3256.5929258842643, 3265.5754751882578, 3294.028261662815, 5959.493443057302, 5980.5514586405325, 6005.6396616203165, 6016.608920420246, 6074.7266373012435, 6084.330723620398, 6112.969435152885, 6115.755369785248, 6129.11127886454, 6146.477549408351, 5836.474717275551, 5993.880122397441, 6012.969935150384, 6028.0355143176885, 6035.758569657164, 5937.732802023833, 5951.256092988377, 5967.582269241111, 5979.073243647242, 5985.551083668829, 5776.451237132465, 5781.21953536284, 5836.153757705194, 5853.64878107315, 5857.677827719516, 5835.79574714883, 5846.736896839568, 5907.054871220584, 5950.821475355746, 6001.549883758648, 3827.73205875586, 3940.7241493095207, 3942.2115576884166, 3976.4035394691027, 3984.641382275609, 5862.882742345044, 5868.677222752619, 5877.588568800143, 5913.467787898938, 5929.258842644669, 5608.046632072476, 5714.285714285715, 5757.050086735641, 5776.104703770922, 5801.100829371454, 5732.856678583069, 5734.168545560787, 5775.624584402, 5829.8251052468495, 5868.471837534642, 5583.050881350099, 5598.356189038313, 5638.661680299195, 5656.632318899258, 5696.316442026983, 5753.165790960204, 5755.223044888887, 5829.271341082364, 5837.970810145922, 5847.707614619337, 5589.245451863946, 5697.0, 5747.310322761128, 5764.423557644202, 5802.564807639528], "yui.html": [681.1043477826657, 700.6636814329122, 704.3238491048589, 718.8059224009518, 742.3244847189059, 12691.36543172841, 12704.364781760922, 12807.167534110276, 12838.743225135504, 12932.48270069196, 11949.940250298758, 12041.939790301058, 12167.695807604814, 12169.0, 12180.878191218086, 642.8457170279146, 663.5090033375292, 816.0859836982588, 830.7175560309508, 837.5519097282955, 822.0956947357888, 825.9545724985123, 829.9170082991712, 840.306746933779, 840.306746933779, 862.4782006885838, 869.5826003518315, 880.295763389286, 881.9867701984475, 882.0429833630486, 640.6348381422591, 678.4165617568912, 821.5399376349204, 842.2503971465401, 850.0437008365589, 626.2234828812285, 626.2485017978444, 626.4862812493757, 627.2191122053027, 631.1794666932968, 11845.526178952832, 12011.279323240633, 12032.578859739868, 12130.939345303304, 12212.755744885142, 10482.68551943443, 10661.84007239892, 10797.352158870493, 10814.74611176765, 10990.670279891616, 8279.37904657147, 8370.874436883452, 8552.341618259514, 8557.058723540405, 8809.735707928772, 2572.1897602255417, 2752.5320695481614, 2950.8819647214086, 3042.497987832005, 3073.1087984484475, 40062.39906401406, 42707.0, 42798.1440371194, 43003.78498107521, 43159.0, 5813.941860581424, 5815.127730840408, 5826.425646659326, 5888.322842873039, 5986.0, 10457.529411176363, 10562.471876406149, 10568.682939511827, 10591.84112238317, 10676.893231067745, 5549.278593782863, 5587.804426845122, 5718.571107166979, 5759.539236861041, 5798.797042103506, 3430.3482338355634, 3444.6555344465855, 3503.194265318991, 3545.6099829018785, 3578.767380120336, 2233.9106435742387, 2274.510980139245, 2280.201929324723, 2290.301458055309, 2291.0034135151263, 341.90768492506885, 349.7237182625748, 353.36218126282307, 354.03525393303045, 354.2631326840166, 412.056390864922, 444.4044979727181, 446.75875027485444, 470.0797243261316, 508.88550076232553, 6669.284021051508, 7029.92970070303, 7077.610731409719, 7178.748743794046, 7318.926810731825, 429.4931980263257, 449.76836928980947, 534.7433232048638, 563.5125616341835, 566.4590316247974, 3184.50640150777, 3224.822634755111, 3394.728421726256, 3538.5930617978747, 3546.1666508370513, 57804.71097644485, 58316.0, 58331.70834145802, 58499.4150058494, 59262.40737592655, 45899.311510326705, 46708.0, 47796.761016194694, 48216.27675584869, 48544.27183592249, 41915.580844191776, 42255.7887210562, 42393.576064238965, 43108.35337469941, 44085.11829763387, 7326.780196594111, 7359.632018399166, 7370.926290737024, 7401.777946661608, 7464.216257292906, 31135.68864311328, 31594.210144745644, 31804.204894877814, 32306.35387292194, 32669.346613068083, 37141.257174856895, 37807.24385512219, 38935.61064389433, 42594.0, 43110.0, 6627.900581491378, 6893.276205998499, 6947.652617369213, 6964.0, 7043.119610048744, 9419.387739796892, 9564.617415303588, 9580.56887440053, 9680.128788409076, 9704.369216000938, 9484.383515071499, 9605.18355939753, 9687.128158465772, 9793.608255669693, 9849.0, 9449.622015119594, 9684.56419461112, 9723.611055557698, 9728.708138755848, 9729.854052189365, 9144.679936202467, 9394.812103758024, 9405.43567385959, 9424.670136545463, 9555.23558115363, 8075.2587393064205, 8086.6361013755695, 8127.268545830903, 8404.495730256203, 8540.786480338042, 7956.880646790187, 7974.960125199337, 8042.638081286239, 8070.798230044295, 8093.87859182101]}, "summary": {"suite": 5872.229535813399, "subtests": {"jquery.html": {"filtered": 5866.256067494353, "value": 5866.256067494353}, "dojo.html": {"filtered": 4662.82087921258, "value": 4662.82087921258}, "mootools.html": {"filtered": 3834.834160723011, "value": 3834.834160723011}, "ext.html": {"filtered": 17322.507091902797, "value": 17322.507091902797}, "prototype.html": {"filtered": 4286.744207542704, "value": 4286.744207542704}, "yui.html": {"filtered": 5263.540003770211, "value": 5263.540003770211}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0070"}, "testrun": {"date": 1446730304, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105030433", "branch": "Firefox", "revision": "59c648a3f95524cb1ee42f2306c1db2698d35258"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 181.0, 180.0, 181.0, 201.0, 183.0, 181.0, 187.0, 184.0, 182.0], "ai-astar": [108.0, 108.0, 103.0, 109.0, 110.0, 113.0, 108.0, 110.0, 110.0, 113.0], "imaging-gaussian-blur": [124.0, 135.0, 140.0, 136.0, 129.0, 136.0, 136.0, 136.0, 129.0, 135.0], "audio-beat-detection": [158.0, 142.0, 178.0, 190.0, 156.0, 168.0, 166.0, 175.0, 202.0, 148.0], "json-stringify-tinderbox": [67.0, 68.0, 73.0, 75.0, 77.0, 77.0, 76.0, 76.0, 76.0, 76.0], "stanford-crypto-pbkdf2": [146.0, 168.0, 170.0, 172.0, 177.0, 166.0, 169.0, 168.0, 168.0, 173.0], "json-parse-financial": [59.0, 58.0, 60.0, 63.0, 68.0, 66.0, 67.0, 74.0, 65.0, 65.0], "stanford-crypto-sha256-iterative": [71.0, 74.0, 77.0, 78.0, 80.0, 78.0, 82.0, 82.0, 85.0, 82.0], "audio-fft": [76.0, 86.0, 97.0, 98.0, 82.0, 80.0, 83.0, 90.0, 95.0, 75.0], "imaging-darkroom": [140.0, 141.0, 141.0, 142.0, 148.0, 144.0, 141.0, 140.0, 142.0, 140.0], "stanford-crypto-ccm": [137.0, 145.0, 148.0, 145.0, 153.0, 142.0, 156.0, 152.0, 145.0, 146.0], "audio-oscillator": [99.0, 107.0, 151.0, 99.0, 105.0, 103.0, 150.0, 100.0, 99.0, 148.0], "stanford-crypto-aes": [88.0, 96.0, 97.0, 99.0, 101.0, 101.0, 100.0, 97.0, 98.0, 96.0], "imaging-desaturate": [114.0, 112.0, 116.0, 118.0, 118.0, 117.0, 114.0, 113.0, 118.0, 115.0]}, "summary": {"suite": 1683.4, "subtests": {"audio-fft": {"filtered": 86.2, "value": 86.2}, "stanford-crypto-pbkdf2": {"filtered": 167.7, "value": 167.7}, "audio-beat-detection": {"filtered": 168.3, "value": 168.3}, "stanford-crypto-ccm": {"filtered": 146.9, "value": 146.9}, "imaging-darkroom": {"filtered": 141.9, "value": 141.9}, "json-parse-financial": {"filtered": 64.5, "value": 64.5}, "audio-oscillator": {"filtered": 116.1, "value": 116.1}, "ai-astar": {"filtered": 109.2, "value": 109.2}, "audio-dft": {"filtered": 183.2, "value": 183.2}, "stanford-crypto-sha256-iterative": {"filtered": 78.9, "value": 78.9}, "json-stringify-tinderbox": {"filtered": 74.1, "value": 74.1}, "imaging-gaussian-blur": {"filtered": 133.6, "value": 133.6}, "stanford-crypto-aes": {"filtered": 97.3, "value": 97.3}, "imaging-desaturate": {"filtered": 115.5, "value": 115.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0070"}, "testrun": {"date": 1446730304, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105030433", "branch": "Firefox", "revision": "59c648a3f95524cb1ee42f2306c1db2698d35258"}}, {"talos_counters": {}, "results": {"DeltaBlue": [225.07314877335133], "Encrypt": [354.10764872521247], "NavierStokes": [6394.904458598726], "Decrypt": [6262.5], "Splay": [881.0572687224669], "Richards": [169.89466530750934], "RegExp": [32774.1935483871], "Earley": [998.003992015968], "Boyer": [14400.0], "RayTrace": [2308.7557603686637]}, "summary": {"suite": 16152.07297378883, "subtests": {"DeltaBlue": {"filtered": 293.7622740000001, "value": 293.7622740000001}, "Encrypt": {"filtered": 751.6951440000001, "value": 751.6951440000001}, "NavierStokes": {"filtered": 232.05976095617524, "value": 232.05976095617524}, "Decrypt": {"filtered": 42.50395209580838, "value": 42.50395209580838}, "Splay": {"filtered": 92.49228500000001, "value": 92.49228500000001}, "RegExp": {"filtered": 27.795802165354306, "value": 27.795802165354306}, "Richards": {"filtered": 207.78757200000007, "value": 207.78757200000007}, "Earley": {"filtered": 667.7959260000002, "value": 667.7959260000002}, "Boyer": {"filtered": 46.282152777777746, "value": 46.282152777777746}, "RayTrace": {"filtered": 320.5141976047904, "value": 320.5141976047904}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0070"}, "testrun": {"date": 1446730304, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105030433", "branch": "Firefox", "revision": "59c648a3f95524cb1ee42f2306c1db2698d35258"}}] 05:51:59 INFO - RETURN: dromaeo_css: 5872.23 05:51:59 INFO - RETURN: kraken: 1683.40 05:51:59 INFO - RETURN: v8_7: 16152.07 05:51:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "16152.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1683.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5872.23"}}} 05:51:59 INFO - Return code: 0 05:51:59 INFO - # TBPL SUCCESS # 05:51:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:59 INFO - 2015-11-05 05:51:59.876 screenresolution[1658:10167] starting screenresolution argv=screenresolution get 05:51:59 INFO - 2015-11-05 05:51:59.880 screenresolution[1658:10167] Display 0: 1600x1200x32@60 05:51:59 INFO - 2015-11-05 05:51:59.886 screenresolution[1659:10170] starting screenresolution argv=screenresolution list 05:51:59 INFO - Available Modes on Display 0 05:51:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:00 INFO - Intel HD Graphics 3000: 05:52:00 INFO - Chipset Model: Intel HD Graphics 3000 05:52:00 INFO - Type: GPU 05:52:00 INFO - Bus: Built-In 05:52:00 INFO - VRAM (Total): 512 MB 05:52:00 INFO - VRAM (Dynamic, Max): 10 05:52:00 INFO - Vendor: Intel (0x8086) 05:52:00 INFO - Device ID: 0x0116 05:52:00 INFO - Revision ID: 0x0009 05:52:00 INFO - Displays: 05:52:00 INFO - Display: 05:52:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:00 INFO - Display Serial Number: 1600x1200 60 05:52:00 INFO - Main Display: Yes 05:52:00 INFO - Mirror: Off 05:52:00 INFO - Online: Yes 05:52:00 INFO - Rotation: Supported 05:52:00 INFO - Return code: 0 05:52:00 INFO - Running post-action listener: _resource_record_post_action 05:52:00 INFO - Running post-run listener: _resource_record_post_run 05:52:01 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 38700032; Write bytes: 685876224; Read time: 4339; Write time: 46520 05:52:01 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 343564800; Write bytes: 344961024; Read time: 34863; Write time: 4503 05:52:01 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 36615168; Write bytes: 339710976; Read time: 3724; Write time: 42000 05:52:01 INFO - Running post-run listener: _upload_blobber_files 05:52:01 INFO - Blob upload gear active. 05:52:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:52:01 INFO - Copying logs to upload dir... 05:52:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1337.548626 ========= master_lag: 1.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2015-11-05 05:52:03.092111) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 05:52:03.095018) ========= 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.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010139 build_url: 'https://queue.taskcluster.net/v1/task/K-ZTeuzlQfW24sZTcRZAoA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.27 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 05:52:03.372194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:52:03.372616) ========= 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.IFVuVcjWES/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.2IYKzn6MVT/Listeners TMPDIR=/var/folders/zq/903g0j_13w99rf0_dqftk74h00000w/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.005344 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:52:03.406397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 05:52:03.406828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 05:52:03.412324) ========= ========= Total master_lag: 8.86 =========