builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0021 starttime: 1447433555.04 results: success (0) buildid: 20151113004332 builduid: 0de6cfc8b5fe4ede99baaf995a23e8e8 revision: 4b6161cc379b78e4fef8195c3f62a1603acf7b59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.044453) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.044908) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.045202) ========= 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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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.006116 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.093802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.094131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.146986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.147417) ========= 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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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.005619 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.208618) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.208944) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.209321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.209617) ========= 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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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-13 08:52:35-- 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% 9.38M=0.001s 2015-11-13 08:52:35 (9.38 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136743 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.664875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.665184) ========= 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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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.020758 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.946428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:35.946777) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6161cc379b78e4fef8195c3f62a1603acf7b59 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6161cc379b78e4fef8195c3f62a1603acf7b59 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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-13 08:52:36,029 truncating revision to first 12 chars 2015-11-13 08:52:36,029 Setting DEBUG logging. 2015-11-13 08:52:36,029 attempt 1/10 2015-11-13 08:52:36,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b6161cc379b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 08:52:36,313 unpacking tar archive at: mozilla-aurora-4b6161cc379b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556478 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:36.521744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:36.522091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:36.536794) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:36.537178) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 08:52:36.537700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-13 08:52:36.538033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:52:36 INFO - MultiFileLogger online at 20151113 08:52:36 in /builds/slave/test 08:52:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:52:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:36 INFO - {'append_to_log': False, 08:52:36 INFO - 'base_work_dir': '/builds/slave/test', 08:52:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:36 INFO - 'branch': 'Mozilla-Aurora', 08:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:36 INFO - 'config_files': ('talos/mac_config.py',), 08:52:36 INFO - 'default_actions': ('clobber', 08:52:36 INFO - 'read-buildbot-config', 08:52:36 INFO - 'download-and-extract', 08:52:36 INFO - 'populate-webroot', 08:52:36 INFO - 'create-virtualenv', 08:52:36 INFO - 'install', 08:52:36 INFO - 'run-tests'), 08:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:36 INFO - 'download_minidump_stackwalk': True, 08:52:36 INFO - 'download_symbols': 'ondemand', 08:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:36 INFO - 'installer_path': 'installer.exe', 08:52:36 INFO - 'log_level': 'info', 08:52:36 INFO - 'log_name': 'talos', 08:52:36 INFO - 'log_to_console': True, 08:52:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:36 INFO - 'opt_config_files': (), 08:52:36 INFO - 'pip_index': False, 08:52:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:36 INFO - 'cmd': ('bash', 08:52:36 INFO - '-c', 08:52:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:36 INFO - 'enabled': True, 08:52:36 INFO - 'halt_on_failure': False, 08:52:36 INFO - 'name': 'check_screen_resolution'},), 08:52:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:36 INFO - 'cmd': ('bash', 08:52:36 INFO - '-c', 08:52:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:36 INFO - 'enabled': True, 08:52:36 INFO - 'halt_on_failure': False, 08:52:36 INFO - 'name': 'check_screen_resolution'},), 08:52:36 INFO - 'run_cmd_checks_enabled': True, 08:52:36 INFO - 'sps_profile': False, 08:52:36 INFO - 'sps_profile_interval': 0, 08:52:36 INFO - 'suite': 'dromaeojs', 08:52:36 INFO - 'system_bits': '64', 08:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:36 INFO - 'title': 't-yosemite-r5-0021', 08:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:36 INFO - 'use_talos_json': True, 08:52:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:36 INFO - 'work_dir': 'build'} 08:52:36 INFO - ##### 08:52:36 INFO - ##### Running clobber step. 08:52:36 INFO - ##### 08:52:36 INFO - Running pre-action listener: _resource_record_pre_action 08:52:36 INFO - Running main action method: clobber 08:52:36 INFO - rmtree: /builds/slave/test/build 08:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:36 INFO - Running post-action listener: _resource_record_post_action 08:52:36 INFO - ##### 08:52:36 INFO - ##### Running read-buildbot-config step. 08:52:36 INFO - ##### 08:52:36 INFO - Running pre-action listener: _resource_record_pre_action 08:52:36 INFO - Running main action method: read_buildbot_config 08:52:36 INFO - Using buildbot properties: 08:52:36 INFO - { 08:52:36 INFO - "properties": { 08:52:36 INFO - "buildnumber": 419, 08:52:36 INFO - "product": "firefox", 08:52:36 INFO - "script_repo_revision": "production", 08:52:36 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 08:52:36 INFO - "repository": "", 08:52:36 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 08:52:36 INFO - "buildid": "20151113004332", 08:52:36 INFO - "slavename": "t-yosemite-r5-0021", 08:52:36 INFO - "pgo_build": "False", 08:52:36 INFO - "basedir": "/builds/slave/test", 08:52:36 INFO - "project": "", 08:52:36 INFO - "platform": "yosemite", 08:52:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:52:36 INFO - "slavebuilddir": "test", 08:52:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:52:36 INFO - "branch": "mozilla-aurora", 08:52:36 INFO - "repo_path": "releases/mozilla-aurora", 08:52:36 INFO - "stage_platform": "macosx64", 08:52:36 INFO - "builduid": "0de6cfc8b5fe4ede99baaf995a23e8e8", 08:52:36 INFO - "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59" 08:52:36 INFO - }, 08:52:36 INFO - "sourcestamp": { 08:52:36 INFO - "repository": "", 08:52:36 INFO - "hasPatch": false, 08:52:36 INFO - "project": "", 08:52:36 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:52:36 INFO - "changes": [ 08:52:36 INFO - { 08:52:36 INFO - "category": null, 08:52:36 INFO - "files": [ 08:52:36 INFO - { 08:52:36 INFO - "url": null, 08:52:36 INFO - "name": "https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 08:52:36 INFO - } 08:52:36 INFO - ], 08:52:36 INFO - "repository": "", 08:52:36 INFO - "rev": "4b6161cc379b78e4fef8195c3f62a1603acf7b59", 08:52:36 INFO - "who": "cbook@mozilla.com", 08:52:36 INFO - "when": 1447409670, 08:52:36 INFO - "number": 6657113, 08:52:36 INFO - "comments": "Bug 1201498 - Service worker update should compare scriptURL to worker URL without fragment, r=bkelly, a=ritu", 08:52:36 INFO - "project": "", 08:52:36 INFO - "at": "Fri 13 Nov 2015 02:14:30", 08:52:36 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:52:36 INFO - "revlink": "", 08:52:36 INFO - "properties": [ 08:52:36 INFO - [ 08:52:36 INFO - "buildid", 08:52:36 INFO - "20151113004332", 08:52:36 INFO - "Change" 08:52:36 INFO - ], 08:52:36 INFO - [ 08:52:36 INFO - "builduid", 08:52:36 INFO - "0de6cfc8b5fe4ede99baaf995a23e8e8", 08:52:36 INFO - "Change" 08:52:36 INFO - ], 08:52:36 INFO - [ 08:52:36 INFO - "pgo_build", 08:52:36 INFO - "False", 08:52:36 INFO - "Change" 08:52:36 INFO - ] 08:52:36 INFO - ], 08:52:36 INFO - "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59" 08:52:36 INFO - } 08:52:36 INFO - ], 08:52:36 INFO - "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59" 08:52:36 INFO - } 08:52:36 INFO - } 08:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 08:52:36 INFO - Running post-action listener: _resource_record_post_action 08:52:36 INFO - ##### 08:52:36 INFO - ##### Running download-and-extract step. 08:52:36 INFO - ##### 08:52:36 INFO - Running pre-action listener: _resource_record_pre_action 08:52:36 INFO - Running main action method: download_and_extract 08:52:36 INFO - mkdir: /builds/slave/test/build/tests 08:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:36 INFO - https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/test_packages.json 08:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/test_packages.json 08:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:52:37 INFO - Downloaded 1149 bytes. 08:52:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:52:37 INFO - Using the following test package requirements: 08:52:37 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:52:37 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 08:52:37 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'jsshell-mac.zip'], 08:52:37 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 08:52:37 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:52:37 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 08:52:37 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 08:52:37 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 08:52:37 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:52:37 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:52:37 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 08:52:37 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:52:37 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')]} 08:52:37 INFO - https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:52:38 INFO - Downloaded 17447693 bytes. 08:52:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 08:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:52:43 INFO - Return code: 0 08:52:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:52:43 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')]} 08:52:43 INFO - https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:52:44 INFO - Downloaded 17447693 bytes. 08:52:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 08:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:52:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:52:51 INFO - Return code: 0 08:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:51 INFO - https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:52:51 INFO - Downloaded 11131307 bytes. 08:52:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 08:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:52:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:52:52 INFO - Return code: 0 08:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:52 INFO - https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 08:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 08:52:55 INFO - Downloaded 107721189 bytes. 08:52:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:52:55 INFO - mkdir: /builds/slave/test/properties 08:52:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:55 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:55 INFO - Contents: 08:52:55 INFO - build_url:https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:52:55 INFO - Running post-action listener: _resource_record_post_action 08:52:55 INFO - Running post-action listener: set_extra_try_arguments 08:52:55 INFO - ##### 08:52:55 INFO - ##### Running populate-webroot step. 08:52:55 INFO - ##### 08:52:55 INFO - Running pre-action listener: _resource_record_pre_action 08:52:55 INFO - Running main action method: populate_webroot 08:52:55 INFO - Guessing talos json url... 08:52:55 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')]} 08:52:55 INFO - https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 08:52:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:52:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:52:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:52:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 08:52:56 INFO - Downloaded 107 bytes. 08:52:56 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:52:56 INFO - Contents: 08:52:56 INFO - 20151113004332 08:52:56 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/4b6161cc379b78e4fef8195c3f62a1603acf7b59 08:52:56 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')]} 08:52:56 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/4b6161cc37/testing/talos/talos.json 08:52:56 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/4b6161cc37/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/4b6161cc37/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:52:57 INFO - Downloaded 4264 bytes. 08:52:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:52:57 INFO - '../fennec_ids.txt'], 08:52:57 INFO - 'tests': ['tcheck2']}, 08:52:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:57 INFO - '--tppagecycles', 08:52:57 INFO - '7'], 08:52:57 INFO - 'tests': ['tsvgm']}}, 08:52:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:52:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:52:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:52:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'tests': ['damp', 'tps']}, 08:52:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['damp', 'tps']}, 08:52:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:52:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:57 INFO - 'other': {'tests': ['a11yr', 08:52:57 INFO - 'ts_paint', 08:52:57 INFO - 'tpaint', 08:52:57 INFO - 'sessionrestore', 08:52:57 INFO - 'sessionrestore_no_auto_restore']}, 08:52:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['a11yr', 08:52:57 INFO - 'ts_paint', 08:52:57 INFO - 'tpaint', 08:52:57 INFO - 'sessionrestore', 08:52:57 INFO - 'sessionrestore_no_auto_restore']}, 08:52:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['a11yr', 08:52:57 INFO - 'ts_paint', 08:52:57 INFO - 'tpaint', 08:52:57 INFO - 'sessionrestore', 08:52:57 INFO - 'sessionrestore_no_auto_restore']}, 08:52:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['a11yr', 08:52:57 INFO - 'ts_paint', 08:52:57 INFO - 'tpaint', 08:52:57 INFO - 'sessionrestore', 08:52:57 INFO - 'sessionrestore_no_auto_restore']}, 08:52:57 INFO - 'other_l64': {'tests': ['a11yr', 08:52:57 INFO - 'ts_paint', 08:52:57 INFO - 'tpaint', 08:52:57 INFO - 'sessionrestore', 08:52:57 INFO - 'sessionrestore_no_auto_restore']}, 08:52:57 INFO - 'other_nol64': {'tests': ['a11yr', 08:52:57 INFO - 'ts_paint', 08:52:57 INFO - 'tpaint', 08:52:57 INFO - 'sessionrestore', 08:52:57 INFO - 'sessionrestore_no_auto_restore']}, 08:52:57 INFO - 'svgr': {'tests': ['tsvgx', 08:52:57 INFO - 'tsvgr_opacity', 08:52:57 INFO - 'tart', 08:52:57 INFO - 'tscrollx', 08:52:57 INFO - 'cart']}, 08:52:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['tsvgx', 08:52:57 INFO - 'tsvgr_opacity', 08:52:57 INFO - 'tart', 08:52:57 INFO - 'tscrollx', 08:52:57 INFO - 'cart']}, 08:52:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'tests': ['tp5o']}, 08:52:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'talos_options': ['--e10s'], 08:52:57 INFO - 'tests': ['tp5o']}, 08:52:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'talos_options': ['--xperf_path', 08:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:57 INFO - 'tests': ['tp5n']}, 08:52:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:57 INFO - 'talos_options': ['--e10s', 08:52:57 INFO - '--xperf_path', 08:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:52:57 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:52:57 INFO - 'tests': ['tp5n']}}, 08:52:57 INFO - 'talos.zip': {'path': '', 08:52:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:57 INFO - Running post-action listener: _resource_record_post_action 08:52:57 INFO - ##### 08:52:57 INFO - ##### Running create-virtualenv step. 08:52:57 INFO - ##### 08:52:57 INFO - Running pre-action listener: _resource_record_pre_action 08:52:57 INFO - Running main action method: create_virtualenv 08:52:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:57 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 08:52:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:57 INFO - Using real prefix '/tools/python27' 08:52:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:02 INFO - Installing pip.................done. 08:53:02 INFO - Return code: 0 08:53:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:02 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 08:53:02 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 08:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:02 INFO - 'HOME': '/Users/cltbld', 08:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:02 INFO - 'LOGNAME': 'cltbld', 08:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:02 INFO - 'MOZ_NO_REMOTE': '1', 08:53:02 INFO - 'NO_EM_RESTART': '1', 08:53:02 INFO - 'PAGER': '/bin/cat', 08:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:02 INFO - 'PWD': '/builds/slave/test', 08:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:02 INFO - 'SHELL': '/bin/bash', 08:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:02 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:02 INFO - 'USER': 'cltbld', 08:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:02 INFO - 'XPC_FLAGS': '0x0', 08:53:02 INFO - 'XPC_SERVICE_NAME': '0', 08:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:03 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 08:53:03 INFO - Cleaning up... 08:53:03 INFO - Return code: 0 08:53:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:53:03 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')]} 08:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:03 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')]} 08:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:03 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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:03 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 08:53:03 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 08:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:03 INFO - 'HOME': '/Users/cltbld', 08:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:03 INFO - 'LOGNAME': 'cltbld', 08:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:03 INFO - 'MOZ_NO_REMOTE': '1', 08:53:03 INFO - 'NO_EM_RESTART': '1', 08:53:03 INFO - 'PAGER': '/bin/cat', 08:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:03 INFO - 'PWD': '/builds/slave/test', 08:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:03 INFO - 'SHELL': '/bin/bash', 08:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:03 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:03 INFO - 'USER': 'cltbld', 08:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:03 INFO - 'XPC_FLAGS': '0x0', 08:53:03 INFO - 'XPC_SERVICE_NAME': '0', 08:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:03 INFO - Downloading/unpacking psutil>=0.7.1 08:53:03 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 08:53:03 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 08:53:03 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 08:53:03 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 08:53:03 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 08:53:03 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 08:53:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:06 INFO - Installing collected packages: psutil 08:53:06 INFO - Running setup.py install for psutil 08:53:06 INFO - building 'psutil._psutil_osx' extension 08:53:06 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 08:53:06 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 08:53:06 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 08:53:07 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 08:53:07 INFO - building 'psutil._psutil_posix' extension 08:53:07 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 08:53:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:07 INFO - ^ 08:53:07 INFO - 1 warning generated. 08:53:07 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 08:53:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:07 INFO - Successfully installed psutil 08:53:07 INFO - Cleaning up... 08:53:07 INFO - Return code: 0 08:53:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:07 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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:07 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 08:53:07 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 08:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:07 INFO - 'HOME': '/Users/cltbld', 08:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:07 INFO - 'LOGNAME': 'cltbld', 08:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:07 INFO - 'MOZ_NO_REMOTE': '1', 08:53:07 INFO - 'NO_EM_RESTART': '1', 08:53:07 INFO - 'PAGER': '/bin/cat', 08:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:07 INFO - 'PWD': '/builds/slave/test', 08:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:07 INFO - 'SHELL': '/bin/bash', 08:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:07 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:07 INFO - 'USER': 'cltbld', 08:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:07 INFO - 'XPC_FLAGS': '0x0', 08:53:07 INFO - 'XPC_SERVICE_NAME': '0', 08:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:53:07 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 08:53:07 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 08:53:07 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 08:53:07 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 08:53:07 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 08:53:07 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 08:53:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:53:10 INFO - Installing collected packages: mozsystemmonitor 08:53:10 INFO - Running setup.py install for mozsystemmonitor 08:53:10 INFO - Successfully installed mozsystemmonitor 08:53:10 INFO - Cleaning up... 08:53:10 INFO - Return code: 0 08:53:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:10 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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:10 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 08:53:10 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 08:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:10 INFO - 'HOME': '/Users/cltbld', 08:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:10 INFO - 'LOGNAME': 'cltbld', 08:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:10 INFO - 'MOZ_NO_REMOTE': '1', 08:53:10 INFO - 'NO_EM_RESTART': '1', 08:53:10 INFO - 'PAGER': '/bin/cat', 08:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:10 INFO - 'PWD': '/builds/slave/test', 08:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:10 INFO - 'SHELL': '/bin/bash', 08:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:10 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:10 INFO - 'USER': 'cltbld', 08:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:10 INFO - 'XPC_FLAGS': '0x0', 08:53:10 INFO - 'XPC_SERVICE_NAME': '0', 08:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 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 08:53:14 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 08:53:15 INFO - Downloading docopt-0.6.1.tar.gz 08:53:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:15 INFO - Running setup.py install for blobuploader 08:53:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:15 INFO - Running setup.py install for requests 08:53:16 INFO - Running setup.py install for docopt 08:53:16 INFO - Successfully installed blobuploader requests docopt 08:53:16 INFO - Cleaning up... 08:53:16 INFO - Return code: 0 08:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:16 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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:16 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 08:53:16 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 08:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:16 INFO - 'HOME': '/Users/cltbld', 08:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:16 INFO - 'LOGNAME': 'cltbld', 08:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:16 INFO - 'MOZ_NO_REMOTE': '1', 08:53:16 INFO - 'NO_EM_RESTART': '1', 08:53:16 INFO - 'PAGER': '/bin/cat', 08:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:16 INFO - 'PWD': '/builds/slave/test', 08:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:16 INFO - 'SHELL': '/bin/bash', 08:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:16 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:16 INFO - 'USER': 'cltbld', 08:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:16 INFO - 'XPC_FLAGS': '0x0', 08:53:16 INFO - 'XPC_SERVICE_NAME': '0', 08:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:16 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-3Pbyh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-g7oXsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-VoZMCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-T1aOpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-QwA1hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-axhpd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-dVUu6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-erxmYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:17 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-WJ_ou6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-DQxHS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-VddAt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-paF1i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-qqEHbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-4AefuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-RQ3w26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:18 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-pwNq86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:19 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-nZh1bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:19 INFO - Running setup.py install for manifestparser 08:53:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:19 INFO - Running setup.py install for mozcrash 08:53:19 INFO - Running setup.py install for mozdebug 08:53:19 INFO - Running setup.py install for mozdevice 08:53:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Running setup.py install for mozfile 08:53:20 INFO - Running setup.py install for mozhttpd 08:53:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Running setup.py install for mozinfo 08:53:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Running setup.py install for mozInstall 08:53:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Running setup.py install for mozleak 08:53:20 INFO - Running setup.py install for mozlog 08:53:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for moznetwork 08:53:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for mozprocess 08:53:21 INFO - Running setup.py install for mozprofile 08:53:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for mozrunner 08:53:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozscreenshot 08:53:22 INFO - Running setup.py install for moztest 08:53:22 INFO - Running setup.py install for mozversion 08:53:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:22 INFO - Cleaning up... 08:53:22 INFO - Return code: 0 08:53:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:22 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')]} 08:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:22 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')]} 08:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:22 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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:22 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 08:53:22 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 08:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:22 INFO - 'HOME': '/Users/cltbld', 08:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:22 INFO - 'LOGNAME': 'cltbld', 08:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:22 INFO - 'MOZ_NO_REMOTE': '1', 08:53:22 INFO - 'NO_EM_RESTART': '1', 08:53:22 INFO - 'PAGER': '/bin/cat', 08:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:22 INFO - 'PWD': '/builds/slave/test', 08:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:22 INFO - 'SHELL': '/bin/bash', 08:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:22 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:22 INFO - 'USER': 'cltbld', 08:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:22 INFO - 'XPC_FLAGS': '0x0', 08:53:22 INFO - 'XPC_SERVICE_NAME': '0', 08:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:22 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Gu9UHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-KrXKbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-JkFf5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-UK4Tx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-k0KtsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-F2xCD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Ec4QZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:23 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-MivaCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-lMOWjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-8a8krJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-tzZEKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-eDw73J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-gFD0MM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-sjZNVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:24 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-0oRNt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:25 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)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:25 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-5j0x4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:25 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)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:25 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Wui0N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:25 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)) 08:53:25 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)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:25 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)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:28 INFO - Downloading blessings-1.5.1.tar.gz 08:53:28 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 08:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:28 INFO - Installing collected packages: blessings 08:53:28 INFO - Running setup.py install for blessings 08:53:28 INFO - Successfully installed blessings 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:28 INFO - Reading from file tmpfile_stdout 08:53:28 INFO - Current package versions: 08:53:28 INFO - blessings == 1.5.1 08:53:28 INFO - blobuploader == 1.2.4 08:53:28 INFO - docopt == 0.6.1 08:53:28 INFO - manifestparser == 1.1 08:53:28 INFO - mozInstall == 1.12 08:53:28 INFO - mozcrash == 0.16 08:53:28 INFO - mozdebug == 0.1 08:53:28 INFO - mozdevice == 0.46 08:53:28 INFO - mozfile == 1.2 08:53:28 INFO - mozhttpd == 0.7 08:53:28 INFO - mozinfo == 0.8 08:53:28 INFO - mozleak == 0.1 08:53:28 INFO - mozlog == 3.0 08:53:28 INFO - moznetwork == 0.27 08:53:28 INFO - mozprocess == 0.22 08:53:28 INFO - mozprofile == 0.27 08:53:28 INFO - mozrunner == 6.11 08:53:28 INFO - mozscreenshot == 0.1 08:53:28 INFO - mozsystemmonitor == 0.0 08:53:28 INFO - moztest == 0.7 08:53:28 INFO - mozversion == 1.4 08:53:28 INFO - psutil == 3.1.1 08:53:28 INFO - requests == 1.2.3 08:53:28 INFO - wsgiref == 0.1.2 08:53:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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 0x1093e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10944e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc888e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, '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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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 08:53:28 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 08:53:28 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 08:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:28 INFO - 'HOME': '/Users/cltbld', 08:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PAGER': '/bin/cat', 08:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:53:28 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - 'XPC_FLAGS': '0x0', 08:53:28 INFO - 'XPC_SERVICE_NAME': '0', 08:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 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)) 08:53:29 INFO - Cleaning up... 08:53:29 INFO - Return code: 0 08:53:29 INFO - Running post-action listener: _resource_record_post_action 08:53:29 INFO - Running post-action listener: _start_resource_monitoring 08:53:29 INFO - Starting resource monitoring. 08:53:29 INFO - ##### 08:53:29 INFO - ##### Running install step. 08:53:29 INFO - ##### 08:53:29 INFO - Running pre-action listener: _resource_record_pre_action 08:53:29 INFO - Running main action method: install 08:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:29 INFO - Reading from file tmpfile_stdout 08:53:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:29 INFO - Reading from file tmpfile_stdout 08:53:29 INFO - Output received: 08:53:29 INFO - Usage: mozinstall [options] installer 08:53:29 INFO - Options: 08:53:29 INFO - -h, --help show this help message and exit 08:53:29 INFO - -d DEST, --destination=DEST 08:53:29 INFO - Directory to install application into. [default: 08:53:29 INFO - "/builds/slave/test"] 08:53:29 INFO - --app=APP Application being installed. [default: firefox] 08:53:29 INFO - mkdir: /builds/slave/test/build/application 08:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:54:11 INFO - Reading from file tmpfile_stdout 08:54:11 INFO - Output received: 08:54:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:54:11 INFO - Running post-action listener: _resource_record_post_action 08:54:11 INFO - ##### 08:54:11 INFO - ##### Running run-tests step. 08:54:11 INFO - ##### 08:54:11 INFO - Running pre-action listener: _resource_record_pre_action 08:54:11 INFO - Running main action method: run_tests 08:54:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:11 INFO - 2015-11-13 08:54:11.496 screenresolution[1921:8364] starting screenresolution argv=screenresolution get 08:54:11 INFO - 2015-11-13 08:54:11.500 screenresolution[1921:8364] Display 0: 1600x1200x32@60 08:54:11 INFO - 2015-11-13 08:54:11.507 screenresolution[1922:8366] starting screenresolution argv=screenresolution list 08:54:11 INFO - Available Modes on Display 0 08:54:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:11 INFO - Intel HD Graphics 3000: 08:54:11 INFO - Chipset Model: Intel HD Graphics 3000 08:54:11 INFO - Type: GPU 08:54:11 INFO - Bus: Built-In 08:54:11 INFO - VRAM (Total): 512 MB 08:54:11 INFO - VRAM (Dynamic, Max): 10 08:54:11 INFO - Vendor: Intel (0x8086) 08:54:11 INFO - Device ID: 0x0116 08:54:11 INFO - Revision ID: 0x0009 08:54:11 INFO - Displays: 08:54:11 INFO - Display: 08:54:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:11 INFO - Display Serial Number: 1600x1200 60 08:54:11 INFO - Main Display: Yes 08:54:11 INFO - Mirror: Off 08:54:11 INFO - Online: Yes 08:54:11 INFO - Rotation: Supported 08:54:11 INFO - Return code: 0 08:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:11 INFO - Python 2.7.3 08:54:11 INFO - Return code: 0 08:54:11 INFO - grabbing minidump binary from tooltool 08:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:11 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 0x1093969f0>, '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 0x1090f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109360990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:11 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 08:54:11 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 08:54:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:11 INFO - Return code: 0 08:54:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0021', '--webServer', 'localhost'] in /builds/slave/test/build 08:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0021 --webServer localhost 08:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfhMuR6G0e/Render', 08:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:11 INFO - 'HOME': '/Users/cltbld', 08:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:11 INFO - 'LOGNAME': 'cltbld', 08:54:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:11 INFO - 'MOZ_NO_REMOTE': '1', 08:54:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:11 INFO - 'NO_EM_RESTART': '1', 08:54:11 INFO - 'PAGER': '/bin/cat', 08:54:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:11 INFO - 'PWD': '/builds/slave/test', 08:54:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:11 INFO - 'SHELL': '/bin/bash', 08:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2MO1mIFIn/Listeners', 08:54:11 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 08:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:11 INFO - 'USER': 'cltbld', 08:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:11 INFO - 'XPC_FLAGS': '0x0', 08:54:11 INFO - 'XPC_SERVICE_NAME': '0', 08:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:54:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0021', '--webServer', 'localhost'] with output_timeout 3600 08:54:12 INFO - mozversion INFO | application_buildid: 20151113004332 08:54:12 INFO - mozversion INFO | application_changeset: 4b6161cc379b78e4fef8195c3f62a1603acf7b59 08:54:12 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:54:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:12 INFO - mozversion INFO | application_name: Firefox 08:54:12 INFO - mozversion INFO | application_remotingname: firefox-dev 08:54:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:54:12 INFO - mozversion INFO | application_vendor: Mozilla 08:54:12 INFO - mozversion INFO | application_version: 44.0a2 08:54:12 INFO - mozversion INFO | platform_buildid: 20151113004332 08:54:12 INFO - mozversion INFO | platform_changeset: 4b6161cc379b78e4fef8195c3f62a1603acf7b59 08:54:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:54:12 INFO - mozversion INFO | platform_version: 44.0a2 08:54:12 INFO - 2015-11-13 08:54:12,320 DEBUG : using testdate: 1447433652 08:54:12 INFO - 2015-11-13 08:54:12,320 DEBUG : actual date: 1447433652 08:54:12 INFO - 2015-11-13 08:54:12,331 INFO : starting webserver on 'localhost:49330' 08:54:12 INFO - 2015-11-13 08:54:12,332 INFO : Starting test suite t-yosemite-r5-0021 08:54:12 INFO - 2015-11-13 08:54:12,332 INFO : Starting test dromaeo_css 08:54:12 INFO - 2015-11-13 08:54:12,332 DEBUG : operating with platform_type : mac_ 08:54:12 INFO - 2015-11-13 08:54:12,333 INFO : Initialising browser for dromaeo_css test... 08:54:12 INFO - 2015-11-13 08:54:12,365 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpiuXvLV/profile http://localhost:49330/getInfo.html 08:54:15 INFO - 2015-11-13 08:54:15,641 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:54:15 INFO - 2015-11-13 08:54:15,641 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:54:15 INFO - 2015-11-13 08:54:15,642 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:54:15 INFO - 2015-11-13 08:54:15,642 DEBUG : BROWSER_OUTPUT: __metrics 08:54:15 INFO - 2015-11-13 08:54:15,663 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:16 INFO - 2015-11-13 08:54:16,398 INFO : Browser initialized. 08:54:16 INFO - 2015-11-13 08:54:16,398 INFO : Running cycle 1/1 for dromaeo_css test... 08:54:16 INFO - 2015-11-13 08:54:16,398 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpiuXvLV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:54:28 INFO - 2015-11-13 08:54:28,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 199335936 08:54:28 INFO - 2015-11-13 08:54:28,498 DEBUG : BROWSER_OUTPUT: 08:55:20 INFO - 2015-11-13 08:55:20,152 DEBUG : BROWSER_OUTPUT: 1447433720142 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] 08:57:30 INFO - 2015-11-13 08:57:30,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49330/tests/dromaeo/cssquery-ext.html) 08:57:31 INFO - 2015-11-13 08:57:31,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 292122624 08:57:31 INFO - 2015-11-13 08:57:31,461 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-11-13 09:00:34,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-ext.html (next: http://localhost:49330/tests/dromaeo/cssquery-jquery.html) 09:00:34 INFO - 2015-11-13 09:00:34,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 341716992 09:00:34 INFO - 2015-11-13 09:00:34,808 DEBUG : BROWSER_OUTPUT: 09:03:37 INFO - 2015-11-13 09:03:37,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49330/tests/dromaeo/cssquery-mootools.html) 09:03:37 INFO - 2015-11-13 09:03:37,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 332308480 09:03:37 INFO - 2015-11-13 09:03:37,665 DEBUG : BROWSER_OUTPUT: 09:06:39 INFO - 2015-11-13 09:06:39,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49330/tests/dromaeo/cssquery-prototype.html) 09:06:40 INFO - 2015-11-13 09:06:40,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 300883968 09:06:40 INFO - 2015-11-13 09:06:40,323 DEBUG : BROWSER_OUTPUT: 09:09:43 INFO - 2015-11-13 09:09:43,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49330/tests/dromaeo/cssquery-yui.html) 09:09:44 INFO - 2015-11-13 09:09:44,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 299696128 09:09:44 INFO - 2015-11-13 09:09:44,171 DEBUG : BROWSER_OUTPUT: 09:12:46 INFO - 2015-11-13 09:12:46,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-yui.html (next: http://localhost:49330/tests/dromaeo/cssquery-dojo.html) 09:12:47 INFO - 2015-11-13 09:12:47,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 346177536 09:12:47 INFO - 2015-11-13 09:12:47,054 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,054 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:12:47 INFO - 2015-11-13 09:12:47,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:12:47 INFO - 2015-11-13 09:12:47,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:12:47 INFO - 2015-11-13 09:12:47,055 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:12:47 INFO - 2015-11-13 09:12:47,055 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2672.572388417853;2755.9035433759823;2770.5290100682882;2785.9831161626;2795.874185661646;4592.885177870551;4620.745858977755;4635.142498637754;4643.210654188788;4644.164050470914;4591.724496530211;4627.652926030544;4637.003044345473;4677.719336839792;4686.062787442516;4114.609112134357;4187.727797693148;4256.59562341577;4274.230638485072;4278.957210427902;4090.7954602269915;4127.133302006582;4202.642775364083;4320.783960801963;4333.414988976479;4213.346931225649;4228.365745138223;4235.3646952957;4280.229558679436;4290.678199135062;4228.281192197303;4251.44731184944;4304.418903448026;4349.478062632473;4408.272635015219;4072.1041370898356;4114.958850411517;4143.295639741251;4161.646260067898;4167.83328666853;4491.101779644085;4493.932591011137;4499.550044995507;4520.299353600197;4538.478075021382;4861.416630004422;4875.658703890729;4884.413870335582;4894.902101957941;4894.99652571222;4732.124556956974;4811.302361157613;4836.22620380741;4932.087563800673;5093.414257360414;4675.766211689436;4701.224297990793;4727.2436410174205;4732.361131247307;4755.595774359149;5007.924881126786;5121.28302037715;5125.436202017775;5136.126858434075;5160.587153027749;4593.563611456906;4738.028704115648;4744.525547445228;4782.736949467743;4893;5023.598112151019;5078.415982162099;5102.056119617882;5115.386153661584;5124.461931497213;4984.028114517707;5009.24861270805;5021.347224860745;5030.0694371541385;5040.722760248222;4489.932651010237;4762.261849413347;4799.352087468217;4856;4933.28467372229;3815.4849095372324;3872.1868407634147;3875.476810630585;3897;3903.2388684206308;3321.186309354224;3512.1570823002294;3523.806190659487;3528.770629909048;3535.151563624763;4450.643948484114;4455.77721113943;4474.418325617649;4597.149527337453;4616.192166370872;5040;5054.646174767731;5060.746962651852;5068.062408454448;5081.949180508148;4398.890027749268;4594.95405045952;4599.72401655895;4631.282151266559;4663.836765713184;4217.578242175758;4228.9788551057045;4232.957670423257;4274.465691788527;4281.636060934793;4956.801727930914;4963.081829861487;4979.950200497949;4988.251762235694;4993.375828021497;4723;4953.826616068421;4970.975145124251;4986.700797951989;5000.64995450315;4761.047790441856;4816.975915120402;4860.586850117779;4890.682105663121;4892.119418504561;4948.604111670986;4978.775955082103;4997.675151115166;5020.121478741279;5035.92446113316;4426.291793313055;4998;5002.199648056294;5019.899602008012;5042.193249080129;4783.808647654055;4864.854054378375;4871.147549178951;4898.706077635211;4898.730569818694;4790.7365094920115;4817.253325734517;4822.8794280143275;4827.8551643450755;4848.3454733610515;4529.705569137996;4740.715557066587;4753.881152971203;4765.833195838129;4777.689450185727;4720.268358404453;4733.431988161443;4744.644151688568;4810.230363141881;4879.707217566957;4745.620350372031;4752.097101550694;4772.141014617402;4794.993051459232;4864.854054378375 09:12:47 INFO - 2015-11-13 09:12:47,059 DEBUG : BROWSER_OUTPUT: |1;ext.html;485.59210263378753;488.479769045966;492.30093267560085;497.9667190579546;518.6343627742442;27333.316667083334;28579.142625721237;33582.49626255608;34103;34607.134821629406;36262;36777.26445471096;36841.44737828928;36916.26167476649;37354;7118.1458225013075;7679.155292917774;7787.805304867367;7844.568548729818;7888.960555197216;7275.090613673291;9312.8603070954;9474.384165029285;9508.096730810563;9538.141567258945;9257.6296948122;9276.768080798;9350.298727595458;9393.577289021976;9436.669716559922;7344.4491663124945;7603.4297427693145;9050.592723327467;9284.071592840695;9439.38643988142;8931;9017.729468115902;9039.096090390974;9049.864252036225;9104.180623743829;33519.16202094967;33921.49117763236;33971.49042764361;34215.31569368599;34223.315533689434;2532.240327901622;2544.9236522904343;2744.3687951771003;2912.2573743695434;3124.875004999797;23452.7654723454;24342.756572434402;24787.13245036433;25093.874530627414;25504.8724756375;1928.9562524273813;1979.712941623471;1999.4701404127918;2005.1177481907914;2049.7540295164526;219445;220494;221946.9999999984;222175;223078;47566.524334756905;52207;52601.73699131556;52673.47326526685;52766.99999999923;44328.335074973904;56243;57551.42448575461;57736.4226357731;58257;14182;14541.636459088608;14552.49066282675;14562.27188640585;14569;11040.116790656728;11128.944355278334;11162.944185279022;11165.38590377537;11173;17540.561485962953;17650.382236621655;17653.646927061385;17844.821551784575;17871.73192402115;7191.496595238283;7417.8145546361775;7430.517016394026;7498.700051997859;7513.549187048795;796.8366484870587;823.9217274358926;844.6241422566899;946.6592026870321;999.0259496990376;24085.879570602036;24257.39356516101;24421.633675494882;24566.263012109666;24585.631215531783;896.462122726359;899.50077706872;1004.6232662751469;1045.9895401046044;1069.3209811769582;12707.428165732565;12794.744105117845;12815.487380504675;12929.482820687068;12982.285974271317;280546;283197;285477;285841;285946;40432;41737.58262417398;44645.77677111659;46226.768866156126;47416.7629161852;1185.5613423033533;1187.5724739093919;1209.1777591237867;1212;1245.4520011195045;21974.121035158416;22995.6550651737;23080.192193273157;23316.65025024592;23597.410064748517;37413.25173496569;37902.052448689006;42221.577784222995;42874.14251714886;42898.571014290705;164190.179049104;165391;167004;168229;168369;24629.876850615634;25738.35654108662;26753.19740407791;26795.464090717687;27543.862280688467;34706.132346691535;35242.295154097286;36265.637343627284;36771.44842827306;36876.631233687316;29913.551296730133;30487.237819054702;31325.686743132275;34375.82812085924;34446.31107377889;30698.232544186572;31216.53175202419;31231.063068107993;31647.683523164473;33328.33343333168;32403.837980809945;32779.18052048718;33174.336513270086;33241.66758332482;33467.83266083654;33670.49494257539;34052.65947340594;34412;34696.479552806224;34791.4781278276;26663.733362666124;27319.72680273251;28747.425051498434;28896;29281.41437171287 09:12:47 INFO - 2015-11-13 09:12:47,060 DEBUG : BROWSER_OUTPUT: |2;jquery.html;291.26746233223435;297.6814808155275;298.337690327473;301.751055379312;308.0988109778896;12907.80638290424;13137.343132843343;14719;14824.629384265385;15296.617584560378;13449.865501345008;15163.090214587104;15265.236738163076;15343.539693809176;15457.458988935361;3876.9612303876884;3942.1721438497807;3982.362821948489;4551.203539380604;4680.157571637104;2980.7019298070236;3073.8924137655185;3084.228942764309;3929.528456585214;3974.5627980922077;3853.6339047790557;3932.075962148893;3958.940615890764;3964.2467931093142;4032.8790136295956;3736.4021756518828;3962.5046869141356;3970.3250447424007;4008.3586626139822;4016.297147999118;3284.064041748114;3300.6864347886913;3303.653116422765;3328.8335583220983;3333.4166520858753;10005.099541041342;10011.048950349705;10166.644167454178;10168.23738219629;10280.177585793119;1482.295909443006;1567.7413226817562;1567.7648352747065;1599.3362754456887;1651.149657926169;7401.814954626124;7619.390448764086;7688.615569221516;7799.610019499002;7822.882656760153;1246.7920767409992;1262.1732765038914;1288.4395288049634;1293.5601895355624;1321.1676643714495;49795.75102124502;51233.23150152751;52018.47981520174;52366.738166309304;52799.47200528022;5370.301860758076;5431;5436.510714035756;5441.047816632074;5481.945180548143;6156.138140660311;6160.7535698571555;6163.137160797492;6166.445019948226;6177.96911015442;4504.144212599661;4523.095380923828;4564.612007979293;4585.128825523207;4597.218472859622;4585.151746926829;4792.496787837296;4842.4189097308545;4879.146149423907;4893.241547560134;2244.1920908472935;2345.4370950971643;2381.129770082416;2392.7607239275935;2392.79661228794;824.1346586084587;832.612835031701;836.2014276366056;881.0748713850431;894.6376717429451;315.4227763193397;323.343612466693;328.3891960952626;343.75421573575017;350.96139424663266;8060.516369017878;8732.388732788644;8737.388382813142;8979.50612716307;9380.108889655472;344.8965310406868;347.83477848022494;347.89910925831225;352.1829355894301;354.024662056034;4885.560299573055;4930.334404855299;4957.628177886673;5000.524950129732;5070.062038522885;466939;480005;486101;487659;491052;60394.39605603975;62301.37698623046;62912.37087629156;63175.6841215791;63236.683816580626;375.7125798763948;376.0392197934304;376.61397068004965;377.4319648928345;379.5805634773591;8222.301104405953;8689.17452841979;8703.303735701254;8776.078511756174;8921;30190.396192075597;30502.237444064074;30559;30567.08298751041;30984.0704778857;39775.80112099421;40478;41117;41241.38137927873;41413;4936.259561065869;5128.435872054146;5154.561862241751;5163.793448262178;5177;8682.956585217033;9030.683926062557;9126;9127.452352858849;9190.954045229731;7705.961470192613;7913.485623434458;7928.524288542706;8031.919680803351;8048.154943730824;6991.161060672548;7655.272749088827;7666.655000525101;7801.765947021599;8043.19568043191;7205.459590530836;8030.116687164291;8094.87857682147;8117;8122.796930076795;5096.796128154981;5102.183650615883;5104.132297509506;5106.7701953412925;5164.561012313995;7577.242275772379;7778.88331675014;7875.212478752079;7920.603969801602;8040.879386809085 09:12:47 INFO - 2015-11-13 09:12:47,062 DEBUG : BROWSER_OUTPUT: |3;mootools.html;698.8427603789145;1259.106034715352;1299.499692618342;1326.9867301326983;1571.1358752686026;6133.478654314383;6318.652474113922;6536.83657908552;6638.568493047948;6705.664716764167;6620.834479138024;6738.595684258948;6770.796876093713;6808.795736127924;6815.5569887957245;1826.6255417639352;1833.8899666020016;1857.6749068912954;1857.7213417987343;1860.0327829528637;1868.841148502379;1896.7249748786417;1903.9809601904012;1911.665458544749;1914.6840771272794;1895.9715604265948;1898.3355825461117;1901.6006638605909;1906.8379187769056;1921.164293532311;1843.7050071988485;1872.447627949758;1872.9344472943449;1873.072828949665;1877.5681593233496;1841.7237414387814;1882.265916292647;1885.7359969604267;1900.1354383755358;1901.7622797150357;5920.082387229986;6632.502562307798;6655.401013908723;6660.134182556285;6672.165979252593;3633.055405594538;3875.806209689504;3941.034446560611;3951.5060617422823;3965.504311961005;2311.722593288816;2421.0799896039393;2427.7936375408112;2430.890609922558;2461.8276720629565;629.5530173576766;694.2086021934998;732.3518685962908;740.104473586955;741.7997140771961;8703.52130632815;8710.738677839676;8729.912700872974;8818.11818818113;8874.334424918157;3422.281320922634;3531.94702079469;3536.4341705327024;3564.108972756811;3568.125809176768;7132.893006604905;7265.636718164071;7290.45321600882;7381.114266287972;7424.443166762514;3995.081131339808;3995.5405128410025;4004.279229738675;4009.8195581198333;4046.7976601169826;3695.722820788452;3711.03513086594;3738.420544815558;3743.6069212732814;3770.698344132463;2729.56326987681;2760.213339198319;2767.405007923266;2797.53840616296;2820.605115283862;878.7890906182598;890.2299510923134;894.879191309165;897.6095398501673;901.4050726520466;1034.4207243943265;1050.1651187305956;1050.4747626186906;1078.5254488025244;1117.3910218930703;6215.098810672427;6231.065340199007;6232.189815323979;6249.406306400884;6250.937490625127;364.4078372644453;371.34828376200136;373.8411175250508;373.8747519580971;374.2048147686167;4873.049755297754;4918.680285781485;4944.98627781304;4945.604351651859;5003.049420610072;7776.494527855672;7777.922220777833;7950.403719721044;7982.560959147303;8003.439759216915;7929.286364227132;7979.72070977513;8001.239882211181;8007.399445041645;8008.519488830689;5443.8094666686475;5535.446455354432;6333.36666333363;6370.171877655967;6382.617042977344;5927.31835838884;6110.419510146529;6160.537959652955;6160.815175544741;6219.160413344322;6544.509161812978;6699.698513566804;7212.062431884031;7212.855742885218;7225.530340527849;7067.081279433641;7275.563466192046;7288.271172882882;7344.118705755343;7366.410687145123;5244.580433565229;5290.65610735301;5316.043112239679;5341.412444631165;5365.114756065362;5873.4126587340925;5961.046232602763;5979.222701048836;5997.970010149921;6014.9097763534455;5575.080111781511;5586.190002449541;5615.691136987505;5653.265075540318;5666.206731057573;5468.507834294933;5470.234167216672;5565.1374037024325;5580.190872323409;5587.273654424899;5600.635958662674;5652.604317697722;5676;5694.430556944272;5731.168980497888;5010.148274793367;5032.6225533084435;5048.040872234411;5056.62075344358;5061.595072394273;5077.416097148875;5089.567386772166;5105.591552675703;5131.794728210979;5152.098382782923 09:12:47 INFO - 2015-11-13 09:12:47,065 DEBUG : BROWSER_OUTPUT: |4;prototype.html;276.84496681858155;282.30975265475905;283.3482989125013;286.26144547068566;290.73543075801;5077.974610126954;5158.716270605115;5199.116150254456;5202.089634313998;5203.76583053763;4949.505049495057;4965.056639238542;5006.674566153198;5059.848204553869;5117.948820511794;3861.131245469761;3888.0862997195777;3889.1638297765976;3900.492935918334;3901.3757798752204;3732.9066773330615;3901.08324543732;3904.141088960424;3926.430667553203;3946.3291240489184;3772.509573755408;3809;3877.8448862045484;3879.3405121129476;3922.17634296798;3844.000559854444;3850.5186851643543;3859.4210868369687;3875.379939209713;3911.550171730245;3329.4839299908554;3340.7160391366765;3345.3643807676463;3357.5803024621923;3383.729301655886;4970.726610036447;4991.401031876198;5001.324821149135;5038.168702164138;5056.772445239973;3977.105151340954;4207.0954744729725;4252.298370768819;4294.71158652403;4383.3424986252;5210.348706411699;5216.556592689626;5274.182501712203;5328.120860058125;5363.410024897258;3588;3589;3635.1820840310984;3650.945235821465;3677.9816100919325;5549.889002219933;5593.52455041322;5604.523615492729;5680.630759000693;5686.601937864351;3598.0824889653495;3599.3701102307514;3613.33153366628;3656.963430365662;3661.56061272649;3582.570091588974;3653.707703383723;3668.248009158116;3685.1155722626377;3716.368217402994;4247.830086796494;4288.5711428857485;4309.806058727365;4314.22343978087;4343.978280108579;4730.692504987165;5157.716325602053;5266.420693723688;5357.732113394315;5436.782528698887;1342.0471465259775;1360.9591712248648;1362.8909687224998;1364.467857535562;1367.931603419845;860.6987554355925;869.4044579463088;884.0717246890739;890.470170248701;894.7584152278848;5049.747512624354;5056.469070747592;5064.164412871834;5071.0872043032605;5079.492050794891;5577.749001294951;5625.943740562542;5629.549636029108;5632.52123569493;5668.036433806263;5097;5118.360204974379;5124.743762811844;5154.3814742230425;5161.612879034087;3011.909642710722;3081.3837232553133;3092.196029032468;3103.5655008298854;3108.424941385851;5642.351129620064;5652.208690783294;5660.773569057274;5678.176664383641;5732.254806875163;5723.399043100415;5736.254286942754;5741.540676745851;5769.798057067983;5801.7389217485315;5640.210370548045;5653.265075540154;5653.321601407857;5687.260656114679;5710.400407957188;5451.018816613047;5677.120046392815;5700.771969121189;5717.22817419643;5724.627899186539;5557.694326812064;5566.721663916869;5580.665160090408;5636.182753500638;5636.985342638364;5724.971375143097;5732.570057245806;5769;5810.389909059488;5857.853553661193;3527.5237842890883;3578.5884623267616;3592.1738000260607;3621.420572708354;3636.036450340715;5404.459554044722;5557.694326812064;5619.241402410622;5632.971835140798;5651.378348381592;5349.545288650353;5404.837854864203;5423.566114710892;5502.9174562382395;5536.474034966672;5390.730463476732;5390.946090539044;5398.595105367034;5425.267588875609;5490.258815060076;5270.7101109439345;5279.234510995961;5301.5493683037375;5356.758945847524;5384.407715151408;5345.1714984177515;5434.076207044733;5436.537894278872;5437.40188579248;5516.558675306046;5324.254604355316;5351.036813373475;5381.757820898148;5397.703126327932;5406 09:12:47 INFO - 2015-11-13 09:12:47,066 DEBUG : BROWSER_OUTPUT: |5;yui.html;528.5797790756349;577.3360635269441;603.5202014398553;653.637231336608;657.1949362031511;11632.418379081044;11795.056395488351;11811.645650630495;11886.167968242227;11923.403829808507;11868.287902725842;12127.696807579792;12175.939120304387;12258.141930064876;12381;614.3395849461824;762.2111114995994;776.5651235308218;777.0558771093121;783.6904422753009;620.8820324138422;623.6476390839184;762.4472257613241;779.1390513482605;779.1974266505508;790.0519376747897;799.9640016199256;801.5471258738794;802.3380710913491;810.6514198894473;627.5732501898707;640.5196102922808;793.714262865368;797.9521228726295;799.588212070784;569.7066011004337;571.5085026876883;572.3761100400583;576.7318197038397;579.8086631411624;11336.149788765875;11616;11767.646970590897;11779.469923853361;11790.115741319349;7867.921320786833;8149.837003259901;8233;8302.879111319955;8309.545829479817;7588.317051465395;7812.765617031441;7973.32226760726;8010.919890801076;8127.878081828718;2430.647556104355;2451.497443024176;2479.3925488255495;2526.772590466867;2558.9360265993314;39681.80159099186;39876.60123398758;40000;40265;40441.39337909934;5529.474699903502;5538;5547.55619550435;5574.749136288877;5758.539316854725;9261.49061801594;9272.119148680864;9294.953525232331;9353;9391.530423478798;5189.221616757516;5328.3605967284175;5362.249285100089;5483.670979741229;5559.221708960748;2975.6577993531023;3043.4978228592036;3063.739582135499;3117.703818137273;3202.1834432219634;2276.7040284762875;2300.0454811253144;2304.297189357262;2308.434433563754;2312.040503191157;323.4178478738262;324.83433448941213;327.43680868905443;331.25137189950885;334.8175244491758;466.153930615931;473.8838984448832;491.6817206869627;510.48696060459;511.7671459485925;6471.288158302583;6654.83362915931;6748.358905903931;6803.965980170067;6905.516613837083;357.7960562479362;374.5019124564323;441.17059927337044;498.7281931347424;508.43309709674185;3124.2345625321486;3160.925285402974;3208.7272581830807;3256.316173603522;3291.1772056985756;51500.48499514957;52218.47781522136;52409;52673.47326526685;52702.47297526975;43324.783376082916;43998.12003759907;44113.77943110328;44395.334069988974;44432;39773.40339894904;39935.60064399319;40178.1964360717;40704.3894341591;40883.7955810225;6886.758963436256;6898.793036208922;7066.681999309941;7215.67529461186;7389.408847292097;28817.42365152727;28821.855890720413;29372.85313573504;29746.405071898007;30066.248343790707;39855.2028959425;40059.399109012804;40357.798211008754;40408.1918361637;40683;6131.448169664752;6415.550911436155;6532.8366790830605;6616.172978377703;6632.635205063768;9455.763605909631;9552.95223523878;9655.758606034624;9657.034296570288;9726.805463890823;9062.093790620886;9183.67857125024;9189.862152067859;9190.080991900757;9220.861687074834;9162.58768355439;9167.724968250963;9176.541172941459;9182.17360437564;9228.40015398997;8997.190252877272;9067.591958361758;9074.092590740873;9083.18251357381;9122.726318210463;7594.696212151452;7604.201558836243;7836.490628109154;8057.153998830038;8093.988251468566;7757;7864.095629002509;7865.252800983897;7914.2085791420395;8133.79665508367 09:12:47 INFO - 2015-11-13 09:12:47,067 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:12:47 INFO - 2015-11-13 09:12:47,067 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:12:47 INFO - 2015-11-13 09:12:47,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 09:12:47 INFO - 2015-11-13 09:12:47,067 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:12:47 INFO - 2015-11-13 09:12:47,067 DEBUG : BROWSER_OUTPUT: __startTimestamp1447434767052__endTimestamp 09:12:47 INFO - 2015-11-13 09:12:47,069 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,069 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:12:47 INFO - 2015-11-13 09:12:47,069 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:12:47 INFO - 2015-11-13 09:12:47,069 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,069 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4583.18 Median:4738.03 stddev:496.04 (10.5%) stddev-sans-first:474.38 09:12:47 INFO - 2015-11-13 09:12:47,071 DEBUG : BROWSER_OUTPUT: Values: 2672.6 2755.9 2770.5 2786.0 2795.9 4592.9 4620.7 4635.1 4643.2 4644.2 4591.7 4627.7 4637.0 4677.7 4686.1 4114.6 4187.7 4256.6 4274.2 4279.0 4090.8 4127.1 4202.6 4320.8 4333.4 4213.3 4228.4 4235.4 4280.2 4290.7 4228.3 4251.4 4304.4 4349.5 4408.3 4072.1 4115.0 4143.3 4161.6 4167.8 4491.1 4493.9 4499.6 4520.3 4538.5 4861.4 4875.7 4884.4 4894.9 4895.0 4732.1 4811.3 4836.2 4932.1 5093.4 4675.8 4701.2 4727.2 4732.4 4755.6 5007.9 5121.3 5125.4 5136.1 5160.6 4593.6 4738.0 4744.5 4782.7 4893.0 5023.6 5078.4 5102.1 5115.4 5124.5 4984.0 5009.2 5021.3 5030.1 5040.7 4489.9 4762.3 4799.4 4856.0 4933.3 3815.5 3872.2 3875.5 3897.0 3903.2 3321.2 3512.2 3523.8 3528.8 3535.2 4450.6 4455.8 4474.4 4597.1 4616.2 5040.0 5054.6 5060.7 5068.1 5081.9 4398.9 4595.0 4599.7 4631.3 4663.8 4217.6 4229.0 4233.0 4274.5 4281.6 4956.8 4963.1 4980.0 4988.3 4993.4 4723.0 4953.8 4971.0 4986.7 5000.6 4761.0 4817.0 4860.6 4890.7 4892.1 4948.6 4978.8 4997.7 5020.1 5035.9 4426.3 4998.0 5002.2 5019.9 5042.2 4783.8 4864.9 4871.1 4898.7 4898.7 4790.7 4817.3 4822.9 4827.9 4848.3 4529.7 4740.7 4753.9 4765.8 4777.7 4720.3 4733.4 4744.6 4810.2 4879.7 4745.6 4752.1 4772.1 4795.0 4864.9 09:12:47 INFO - 2015-11-13 09:12:47,071 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,071 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38191.60 Median:33285.00 stddev:59789.91 (179.6%) stddev-sans-first:59890.61 09:12:47 INFO - 2015-11-13 09:12:47,073 DEBUG : BROWSER_OUTPUT: Values: 485.6 488.5 492.3 498.0 518.6 27333.3 28579.1 33582.5 34103.0 34607.1 36262.0 36777.3 36841.4 36916.3 37354.0 7118.1 7679.2 7787.8 7844.6 7889.0 7275.1 9312.9 9474.4 9508.1 9538.1 9257.6 9276.8 9350.3 9393.6 9436.7 7344.4 7603.4 9050.6 9284.1 9439.4 8931.0 9017.7 9039.1 9049.9 9104.2 33519.2 33921.5 33971.5 34215.3 34223.3 2532.2 2544.9 2744.4 2912.3 3124.9 23452.8 24342.8 24787.1 25093.9 25504.9 1929.0 1979.7 1999.5 2005.1 2049.8 219445.0 220494.0 221947.0 222175.0 223078.0 47566.5 52207.0 52601.7 52673.5 52767.0 44328.3 56243.0 57551.4 57736.4 58257.0 14182.0 14541.6 14552.5 14562.3 14569.0 11040.1 11128.9 11162.9 11165.4 11173.0 17540.6 17650.4 17653.6 17844.8 17871.7 7191.5 7417.8 7430.5 7498.7 7513.5 796.8 823.9 844.6 946.7 999.0 24085.9 24257.4 24421.6 24566.3 24585.6 896.5 899.5 1004.6 1046.0 1069.3 12707.4 12794.7 12815.5 12929.5 12982.3 280546.0 283197.0 285477.0 285841.0 285946.0 40432.0 41737.6 44645.8 46226.8 47416.8 1185.6 1187.6 1209.2 1212.0 1245.5 21974.1 22995.7 23080.2 23316.7 23597.4 37413.3 37902.1 42221.6 42874.1 42898.6 164190.2 165391.0 167004.0 168229.0 168369.0 24629.9 25738.4 26753.2 26795.5 27543.9 34706.1 35242.3 36265.6 36771.4 36876.6 29913.6 30487.2 31325.7 34375.8 34446.3 30698.2 31216.5 31231.1 31647.7 33328.3 32403.8 32779.2 33174.3 33241.7 33467.8 33670.5 34052.7 34412.0 34696.5 34791.5 26663.7 27319.7 28747.4 28896.0 29281.4 09:12:47 INFO - 2015-11-13 09:12:47,073 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,073 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23189.69 Median:235809.58 stddev:79079.10 (33.5%) stddev-sans-first:79282.25 09:12:47 INFO - 2015-11-13 09:12:47,073 DEBUG : BROWSER_OUTPUT: Values: 291.3 297.7 298.3 301.8 308.1 12907.8 13137.3 14719.0 14824.6 15296.6 13449.9 15163.1 15265.2 15343.5 15457.5 3877.0 3942.2 3982.4 4551.2 4680.2 2980.7 3073.9 3084.2 3929.5 3974.6 3853.6 3932.1 3958.9 3964.2 4032.9 3736.4 3962.5 3970.3 4008.4 4016.3 3284.1 3300.7 3303.7 3328.8 3333.4 10005.1 10011.0 10166.6 10168.2 10280.2 1482.3 1567.7 1567.8 1599.3 1651.1 7401.8 7619.4 7688.6 7799.6 7822.9 1246.8 1262.2 1288.4 1293.6 1321.2 49795.8 51233.2 52018.5 52366.7 52799.5 5370.3 5431.0 5436.5 5441.0 5481.9 6156.1 6160.8 6163.1 6166.4 6178.0 4504.1 4523.1 4564.6 4585.1 4597.2 4585.2 4792.5 4842.4 4879.1 4893.2 2244.2 2345.4 2381.1 2392.8 2392.8 824.1 832.6 836.2 881.1 894.6 315.4 323.3 328.4 343.8 351.0 8060.5 8732.4 8737.4 8979.5 9380.1 344.9 347.8 347.9 352.2 354.0 4885.6 4930.3 4957.6 5000.5 5070.1 466939.0 480005.0 486101.0 487659.0 491052.0 60394.4 62301.4 62912.4 63175.7 63236.7 375.7 376.0 376.6 377.4 379.6 8222.3 8689.2 8703.3 8776.1 8921.0 30190.4 30502.2 30559.0 30567.1 30984.1 39775.8 40478.0 41117.0 41241.4 41413.0 4936.3 5128.4 5154.6 5163.8 5177.0 8683.0 9030.7 9126.0 9127.5 9191.0 7706.0 7913.5 7928.5 8031.9 8048.2 6991.2 7655.3 7666.7 7801.8 8043.2 7205.5 8030.1 8094.9 8117.0 8122.8 5096.8 5102.2 5104.1 5106.8 5164.6 7577.2 7778.9 7875.2 7920.6 8040.9 09:12:47 INFO - 2015-11-13 09:12:47,073 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,073 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4485.41 Median:5469.37 stddev:2381.85 (43.5%) stddev-sans-first:2371.52 09:12:47 INFO - 2015-11-13 09:12:47,075 DEBUG : BROWSER_OUTPUT: Values: 698.8 1259.1 1299.5 1327.0 1571.1 6133.5 6318.7 6536.8 6638.6 6705.7 6620.8 6738.6 6770.8 6808.8 6815.6 1826.6 1833.9 1857.7 1857.7 1860.0 1868.8 1896.7 1904.0 1911.7 1914.7 1896.0 1898.3 1901.6 1906.8 1921.2 1843.7 1872.4 1872.9 1873.1 1877.6 1841.7 1882.3 1885.7 1900.1 1901.8 5920.1 6632.5 6655.4 6660.1 6672.2 3633.1 3875.8 3941.0 3951.5 3965.5 2311.7 2421.1 2427.8 2430.9 2461.8 629.6 694.2 732.4 740.1 741.8 8703.5 8710.7 8729.9 8818.1 8874.3 3422.3 3531.9 3536.4 3564.1 3568.1 7132.9 7265.6 7290.5 7381.1 7424.4 3995.1 3995.5 4004.3 4009.8 4046.8 3695.7 3711.0 3738.4 3743.6 3770.7 2729.6 2760.2 2767.4 2797.5 2820.6 878.8 890.2 894.9 897.6 901.4 1034.4 1050.2 1050.5 1078.5 1117.4 6215.1 6231.1 6232.2 6249.4 6250.9 364.4 371.3 373.8 373.9 374.2 4873.0 4918.7 4945.0 4945.6 5003.0 7776.5 7777.9 7950.4 7982.6 8003.4 7929.3 7979.7 8001.2 8007.4 8008.5 5443.8 5535.4 6333.4 6370.2 6382.6 5927.3 6110.4 6160.5 6160.8 6219.2 6544.5 6699.7 7212.1 7212.9 7225.5 7067.1 7275.6 7288.3 7344.1 7366.4 5244.6 5290.7 5316.0 5341.4 5365.1 5873.4 5961.0 5979.2 5998.0 6014.9 5575.1 5586.2 5615.7 5653.3 5666.2 5468.5 5470.2 5565.1 5580.2 5587.3 5600.6 5652.6 5676.0 5694.4 5731.2 5010.1 5032.6 5048.0 5056.6 5061.6 5077.4 5089.6 5105.6 5131.8 5152.1 09:12:47 INFO - 2015-11-13 09:12:47,075 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,076 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4479.84 Median:5156.05 stddev:1377.62 (26.7%) stddev-sans-first:1344.88 09:12:47 INFO - 2015-11-13 09:12:47,076 DEBUG : BROWSER_OUTPUT: Values: 276.8 282.3 283.3 286.3 290.7 5078.0 5158.7 5199.1 5202.1 5203.8 4949.5 4965.1 5006.7 5059.8 5117.9 3861.1 3888.1 3889.2 3900.5 3901.4 3732.9 3901.1 3904.1 3926.4 3946.3 3772.5 3809.0 3877.8 3879.3 3922.2 3844.0 3850.5 3859.4 3875.4 3911.6 3329.5 3340.7 3345.4 3357.6 3383.7 4970.7 4991.4 5001.3 5038.2 5056.8 3977.1 4207.1 4252.3 4294.7 4383.3 5210.3 5216.6 5274.2 5328.1 5363.4 3588.0 3589.0 3635.2 3650.9 3678.0 5549.9 5593.5 5604.5 5680.6 5686.6 3598.1 3599.4 3613.3 3657.0 3661.6 3582.6 3653.7 3668.2 3685.1 3716.4 4247.8 4288.6 4309.8 4314.2 4344.0 4730.7 5157.7 5266.4 5357.7 5436.8 1342.0 1361.0 1362.9 1364.5 1367.9 860.7 869.4 884.1 890.5 894.8 5049.7 5056.5 5064.2 5071.1 5079.5 5577.7 5625.9 5629.5 5632.5 5668.0 5097.0 5118.4 5124.7 5154.4 5161.6 3011.9 3081.4 3092.2 3103.6 3108.4 5642.4 5652.2 5660.8 5678.2 5732.3 5723.4 5736.3 5741.5 5769.8 5801.7 5640.2 5653.3 5653.3 5687.3 5710.4 5451.0 5677.1 5700.8 5717.2 5724.6 5557.7 5566.7 5580.7 5636.2 5637.0 5725.0 5732.6 5769.0 5810.4 5857.9 3527.5 3578.6 3592.2 3621.4 3636.0 5404.5 5557.7 5619.2 5633.0 5651.4 5349.5 5404.8 5423.6 5502.9 5536.5 5390.7 5390.9 5398.6 5425.3 5490.3 5270.7 5279.2 5301.5 5356.8 5384.4 5345.2 5434.1 5436.5 5437.4 5516.6 5324.3 5351.0 5381.8 5397.7 5406.0 09:12:47 INFO - 2015-11-13 09:12:47,076 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,077 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11330.09 Median:570.61 stddev:14089.23 (2469.2%) stddev-sans-first:14105.40 09:12:47 INFO - 2015-11-13 09:12:47,078 DEBUG : BROWSER_OUTPUT: Values: 528.6 577.3 603.5 653.6 657.2 11632.4 11795.1 11811.6 11886.2 11923.4 11868.3 12127.7 12175.9 12258.1 12381.0 614.3 762.2 776.6 777.1 783.7 620.9 623.6 762.4 779.1 779.2 790.1 800.0 801.5 802.3 810.7 627.6 640.5 793.7 798.0 799.6 569.7 571.5 572.4 576.7 579.8 11336.1 11616.0 11767.6 11779.5 11790.1 7867.9 8149.8 8233.0 8302.9 8309.5 7588.3 7812.8 7973.3 8010.9 8127.9 2430.6 2451.5 2479.4 2526.8 2558.9 39681.8 39876.6 40000.0 40265.0 40441.4 5529.5 5538.0 5547.6 5574.7 5758.5 9261.5 9272.1 9295.0 9353.0 9391.5 5189.2 5328.4 5362.2 5483.7 5559.2 2975.7 3043.5 3063.7 3117.7 3202.2 2276.7 2300.0 2304.3 2308.4 2312.0 323.4 324.8 327.4 331.3 334.8 466.2 473.9 491.7 510.5 511.8 6471.3 6654.8 6748.4 6804.0 6905.5 357.8 374.5 441.2 498.7 508.4 3124.2 3160.9 3208.7 3256.3 3291.2 51500.5 52218.5 52409.0 52673.5 52702.5 43324.8 43998.1 44113.8 44395.3 44432.0 39773.4 39935.6 40178.2 40704.4 40883.8 6886.8 6898.8 7066.7 7215.7 7389.4 28817.4 28821.9 29372.9 29746.4 30066.2 39855.2 40059.4 40357.8 40408.2 40683.0 6131.4 6415.6 6532.8 6616.2 6632.6 9455.8 9553.0 9655.8 9657.0 9726.8 9062.1 9183.7 9189.9 9190.1 9220.9 9162.6 9167.7 9176.5 9182.2 9228.4 8997.2 9067.6 9074.1 9083.2 9122.7 7594.7 7604.2 7836.5 8057.2 8094.0 7757.0 7864.1 7865.3 7914.2 8133.8 09:12:47 INFO - 2015-11-13 09:12:47,078 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:12:47 INFO - 2015-11-13 09:12:47,078 DEBUG : BROWSER_OUTPUT: 09:12:47 INFO - 2015-11-13 09:12:47,768 INFO : Browser exited with error code: 0 09:12:47 INFO - 2015-11-13 09:12:47,800 INFO : Completed test dromaeo_css (00:18:35) 09:12:47 INFO - 2015-11-13 09:12:47,800 INFO : Starting test kraken 09:12:47 INFO - 2015-11-13 09:12:47,800 DEBUG : operating with platform_type : mac_ 09:12:47 INFO - 2015-11-13 09:12:47,800 INFO : Initialising browser for kraken test... 09:12:47 INFO - 2015-11-13 09:12:47,815 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpNAlRQz/profile http://localhost:49330/getInfo.html 09:12:50 INFO - 2015-11-13 09:12:50,310 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:12:50 INFO - 2015-11-13 09:12:50,310 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:12:50 INFO - 2015-11-13 09:12:50,311 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:12:50 INFO - 2015-11-13 09:12:50,311 DEBUG : BROWSER_OUTPUT: __metrics 09:12:50 INFO - 2015-11-13 09:12:50,326 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:51 INFO - 2015-11-13 09:12:51,070 INFO : Browser initialized. 09:12:51 INFO - 2015-11-13 09:12:51,070 INFO : Running cycle 1/1 for kraken test... 09:12:51 INFO - 2015-11-13 09:12:51,070 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpNAlRQz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:13:03 INFO - 2015-11-13 09:13:03,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 198795264 09:13:03 INFO - 2015-11-13 09:13:03,131 DEBUG : BROWSER_OUTPUT: 09:13:06 INFO - 2015-11-13 09:13:06,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:06 INFO - 2015-11-13 09:13:06,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 265945088 09:13:06 INFO - 2015-11-13 09:13:06,667 DEBUG : BROWSER_OUTPUT: 09:13:09 INFO - 2015-11-13 09:13:09,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-dft) 09:13:10 INFO - 2015-11-13 09:13:10,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 279015424 09:13:10 INFO - 2015-11-13 09:13:10,299 DEBUG : BROWSER_OUTPUT: 09:13:13 INFO - 2015-11-13 09:13:13,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-fft) 09:13:14 INFO - 2015-11-13 09:13:14,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 269545472 09:13:14 INFO - 2015-11-13 09:13:14,113 DEBUG : BROWSER_OUTPUT: 09:13:16 INFO - 2015-11-13 09:13:16,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-oscillator) 09:13:17 INFO - 2015-11-13 09:13:17,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 269520896 09:13:17 INFO - 2015-11-13 09:13:17,007 DEBUG : BROWSER_OUTPUT: 09:13:19 INFO - 2015-11-13 09:13:19,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:20 INFO - 2015-11-13 09:13:20,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 269484032 09:13:20 INFO - 2015-11-13 09:13:20,075 DEBUG : BROWSER_OUTPUT: 09:13:23 INFO - 2015-11-13 09:13:23,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49330/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:24 INFO - 2015-11-13 09:13:24,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 265633792 09:13:24 INFO - 2015-11-13 09:13:24,177 DEBUG : BROWSER_OUTPUT: 09:13:27 INFO - 2015-11-13 09:13:27,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49330/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:28 INFO - 2015-11-13 09:13:28,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 264847360 09:13:28 INFO - 2015-11-13 09:13:28,395 DEBUG : BROWSER_OUTPUT: 09:13:31 INFO - 2015-11-13 09:13:31,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49330/tests/kraken/driver.html?testName=json-parse-financial) 09:13:32 INFO - 2015-11-13 09:13:32,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 266719232 09:13:32 INFO - 2015-11-13 09:13:32,272 DEBUG : BROWSER_OUTPUT: 09:13:34 INFO - 2015-11-13 09:13:34,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:34 INFO - 2015-11-13 09:13:34,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 301281280 09:13:34 INFO - 2015-11-13 09:13:34,615 DEBUG : BROWSER_OUTPUT: 09:13:36 INFO - 2015-11-13 09:13:36,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:37 INFO - 2015-11-13 09:13:37,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 301465600 09:13:37 INFO - 2015-11-13 09:13:37,257 DEBUG : BROWSER_OUTPUT: 09:13:39 INFO - 2015-11-13 09:13:39,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:40 INFO - 2015-11-13 09:13:40,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 308011008 09:13:40 INFO - 2015-11-13 09:13:40,170 DEBUG : BROWSER_OUTPUT: 09:13:43 INFO - 2015-11-13 09:13:43,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:43 INFO - 2015-11-13 09:13:43,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 309989376 09:13:43 INFO - 2015-11-13 09:13:43,724 DEBUG : BROWSER_OUTPUT: 09:13:46 INFO - 2015-11-13 09:13:46,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:47 INFO - 2015-11-13 09:13:47,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 309313536 09:13:47 INFO - 2015-11-13 09:13:47,207 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49330/tests/kraken/driver.html?testName=ai-astar) 09:13:49 INFO - 2015-11-13 09:13:49,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 369168384 09:13:49 INFO - 2015-11-13 09:13:49,403 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,403 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:13:49 INFO - 2015-11-13 09:13:49,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:13:49 INFO - 2015-11-13 09:13:49,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:13:49 INFO - 2015-11-13 09:13:49,404 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:13:49 INFO - 2015-11-13 09:13:49,404 DEBUG : BROWSER_OUTPUT: |0;ai-astar;126;128;132;132;126;127;140;134;132;127 09:13:49 INFO - 2015-11-13 09:13:49,404 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;156;196;185;154;178;152;191;181;152 09:13:49 INFO - 2015-11-13 09:13:49,405 DEBUG : BROWSER_OUTPUT: |2;audio-dft;189;197;197;187;187;192;196;193;189;187 09:13:49 INFO - 2015-11-13 09:13:49,405 DEBUG : BROWSER_OUTPUT: |3;audio-fft;94;94;95;146;81;85;85;85;134;75 09:13:49 INFO - 2015-11-13 09:13:49,405 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;116;116;166;106;109;112;153;102;103;155 09:13:49 INFO - 2015-11-13 09:13:49,405 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;149;137;136;141;148;136;149;149;138 09:13:49 INFO - 2015-11-13 09:13:49,405 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;153;154;150;147;154;153;150;146;153;152 09:13:49 INFO - 2015-11-13 09:13:49,406 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;124;124;122;119;118;122;124;124;124 09:13:49 INFO - 2015-11-13 09:13:49,406 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;73;74;74;78;76;77;85;67;66 09:13:49 INFO - 2015-11-13 09:13:49,406 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;75;75;80;82;79;80;79;80;79 09:13:49 INFO - 2015-11-13 09:13:49,406 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;99;100;99;99;100;101;100;96;100 09:13:49 INFO - 2015-11-13 09:13:49,406 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;148;158;156;148;153;157;145;152;149;149 09:13:49 INFO - 2015-11-13 09:13:49,406 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;170;163;178;177;172;156;170;176;177;174 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;80;83;84;84;83;84;83;79;80 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: __startTimestamp1447434829398__endTimestamp 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,407 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:13:49 INFO - 2015-11-13 09:13:49,408 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:13:49 INFO - 2015-11-13 09:13:49,408 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,408 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:130.40 Median:132.00 stddev:4.48 (3.4%) stddev-sans-first:4.46 09:13:49 INFO - 2015-11-13 09:13:49,408 DEBUG : BROWSER_OUTPUT: Values: 126.0 128.0 132.0 132.0 126.0 127.0 140.0 134.0 132.0 127.0 09:13:49 INFO - 2015-11-13 09:13:49,408 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,408 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:173.00 Median:183.00 stddev:17.52 (9.6%) stddev-sans-first:18.03 09:13:49 INFO - 2015-11-13 09:13:49,409 DEBUG : BROWSER_OUTPUT: Values: 185.0 156.0 196.0 185.0 154.0 178.0 152.0 191.0 181.0 152.0 09:13:49 INFO - 2015-11-13 09:13:49,409 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,409 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:191.40 Median:192.50 stddev:4.17 (2.2%) stddev-sans-first:4.33 09:13:49 INFO - 2015-11-13 09:13:49,409 DEBUG : BROWSER_OUTPUT: Values: 189.0 197.0 197.0 187.0 187.0 192.0 196.0 193.0 189.0 187.0 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.40 Median:85.00 stddev:23.48 (27.6%) stddev-sans-first:24.87 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 95.0 146.0 81.0 85.0 85.0 85.0 134.0 75.0 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.80 Median:116.00 stddev:24.29 (20.9%) stddev-sans-first:25.60 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: Values: 116.0 116.0 166.0 106.0 109.0 112.0 153.0 102.0 103.0 155.0 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,410 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.20 Median:148.50 stddev:6.07 (4.1%) stddev-sans-first:6.06 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 137.0 136.0 141.0 148.0 136.0 149.0 149.0 138.0 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:151.20 Median:153.00 stddev:2.86 (1.9%) stddev-sans-first:2.96 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: Values: 153.0 154.0 150.0 147.0 154.0 153.0 150.0 146.0 153.0 152.0 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.30 Median:124.00 stddev:2.21 (1.8%) stddev-sans-first:2.35 09:13:49 INFO - 2015-11-13 09:13:49,411 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 124.0 122.0 119.0 118.0 122.0 124.0 124.0 124.0 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:75.00 stddev:6.33 (8.4%) stddev-sans-first:5.73 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: Values: 64.0 73.0 74.0 74.0 78.0 76.0 77.0 85.0 67.0 66.0 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.00 Median:79.50 stddev:3.30 (4.2%) stddev-sans-first:2.33 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 75.0 80.0 82.0 79.0 80.0 79.0 80.0 79.0 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.80 Median:95.00 stddev:2.15 (2.3%) stddev-sans-first:1.41 09:13:49 INFO - 2015-11-13 09:13:49,412 DEBUG : BROWSER_OUTPUT: Values: 94.0 99.0 100.0 99.0 99.0 100.0 101.0 100.0 96.0 100.0 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:152.50 stddev:4.40 (2.9%) stddev-sans-first:4.48 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: Values: 148.0 158.0 156.0 148.0 153.0 157.0 145.0 152.0 149.0 149.0 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:175.00 stddev:7.04 (4.0%) stddev-sans-first:7.45 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: Values: 170.0 163.0 178.0 177.0 172.0 156.0 170.0 176.0 177.0 174.0 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.90 Median:83.00 stddev:2.13 (2.6%) stddev-sans-first:1.99 09:13:49 INFO - 2015-11-13 09:13:49,413 DEBUG : BROWSER_OUTPUT: Values: 79.0 80.0 83.0 84.0 84.0 83.0 84.0 83.0 79.0 80.0 09:13:49 INFO - 2015-11-13 09:13:49,414 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:13:49 INFO - 2015-11-13 09:13:49,414 DEBUG : BROWSER_OUTPUT: 09:13:50 INFO - 2015-11-13 09:13:50,159 INFO : Browser exited with error code: 0 09:13:50 INFO - 2015-11-13 09:13:50,216 INFO : Completed test kraken (00:01:02) 09:13:50 INFO - 2015-11-13 09:13:50,216 INFO : Starting test v8_7 09:13:50 INFO - 2015-11-13 09:13:50,216 DEBUG : operating with platform_type : mac_ 09:13:50 INFO - 2015-11-13 09:13:50,216 INFO : Initialising browser for v8_7 test... 09:13:50 INFO - 2015-11-13 09:13:50,231 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpvdfJRr/profile http://localhost:49330/getInfo.html 09:13:52 INFO - 2015-11-13 09:13:52,696 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:13:52 INFO - 2015-11-13 09:13:52,697 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:13:52 INFO - 2015-11-13 09:13:52,697 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:13:52 INFO - 2015-11-13 09:13:52,697 DEBUG : BROWSER_OUTPUT: __metrics 09:13:52 INFO - 2015-11-13 09:13:52,713 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:53 INFO - 2015-11-13 09:13:53,472 INFO : Browser initialized. 09:13:53 INFO - 2015-11-13 09:13:53,473 INFO : Running cycle 1/1 for v8_7 test... 09:13:53 INFO - 2015-11-13 09:13:53,473 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpvdfJRr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:14:05 INFO - 2015-11-13 09:14:05,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 200278016 09:14:05 INFO - 2015-11-13 09:14:05,554 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/v8_7/run.html (next: http://localhost:49330/tests/v8_7/run.html) 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 521203712 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: |0;Richards;196.23233908948194 09:14:28 INFO - 2015-11-13 09:14:28,668 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;228.83295194508008 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |2;Encrypt;376.3643206624012 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6823.1292517006805 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1236.0939431396787 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |5;Earley;811.0300081103001 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |6;Boyer;14652.173913043478 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |7;RegExp;34322.03389830508 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |8;Splay;680.7351940095303 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6869.86301369863 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: __startTimestamp1447434868665__endTimestamp 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:14:28 INFO - 2015-11-13 09:14:28,669 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:196.23 Median:196.23 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: Values: 196.2 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:228.83 Median:228.83 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: Values: 228.8 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:376.36 Median:376.36 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: Values: 376.4 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6823.13 Median:6823.13 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: Values: 6823.1 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,670 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1236.09 Median:1236.09 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: Values: 1236.1 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:811.03 Median:811.03 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: Values: 811.0 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14652.17 Median:14652.17 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,671 DEBUG : BROWSER_OUTPUT: Values: 14652.2 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34322.03 Median:34322.03 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: Values: 34322.0 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:680.74 Median:680.74 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: Values: 680.7 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6869.86 Median:6869.86 stddev:0.00 (0.0%) 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: Values: 6869.9 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:14:28 INFO - 2015-11-13 09:14:28,672 DEBUG : BROWSER_OUTPUT: 09:14:29 INFO - 2015-11-13 09:14:29,419 INFO : Browser exited with error code: 0 09:14:29 INFO - 2015-11-13 09:14:29,442 INFO : Completed test v8_7 (00:00:39) 09:14:29 INFO - 2015-11-13 09:14:29,912 INFO : Completed test suite (00:20:17) 09:14:29 INFO - 2015-11-13 09:14:29,912 DEBUG : Working with test: dromaeo_css 09:14:29 INFO - 2015-11-13 09:14:29,912 DEBUG : Generating results file: dromaeo_css 09:14:29 INFO - 2015-11-13 09:14:29,913 DEBUG : Working with test: kraken 09:14:29 INFO - 2015-11-13 09:14:29,913 DEBUG : Generating results file: kraken 09:14:29 INFO - 2015-11-13 09:14:29,913 INFO : javascript benchmark 09:14:29 INFO - 2015-11-13 09:14:29,913 DEBUG : Working with test: v8_7 09:14:29 INFO - 2015-11-13 09:14:29,913 DEBUG : Generating results file: v8_7 09:14:29 INFO - 2015-11-13 09:14:29,913 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:29 INFO - 2015-11-13 09:14:29,971 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:14:29 INFO - 2015-11-13 09:14:29,972 DEBUG : process_Request line: dromaeo_css 5529.05 graph.html#tests=[[72,52,55]] 09:14:29 INFO - 2015-11-13 09:14:29,972 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:30 INFO - 2015-11-13 09:14:30,001 DEBUG : process_Request line: kraken 1787.60 graph.html#tests=[[232,52,55]] 09:14:30 INFO - 2015-11-13 09:14:30,001 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:30 INFO - 2015-11-13 09:14:30,030 DEBUG : process_Request line: v8_7 17241.34 graph.html#tests=[[230,52,55]] 09:14:30 INFO - 2015-11-13 09:14:30,031 INFO : javascript benchmark 09:14:30 INFO - 2015-11-13 09:14:30,033 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [291.26746233223435, 297.6814808155275, 298.337690327473, 301.751055379312, 308.0988109778896, 12907.80638290424, 13137.343132843343, 14719.0, 14824.629384265385, 15296.617584560378, 13449.865501345008, 15163.090214587104, 15265.236738163076, 15343.539693809176, 15457.458988935361, 3876.9612303876884, 3942.1721438497807, 3982.362821948489, 4551.203539380604, 4680.157571637104, 2980.7019298070236, 3073.8924137655185, 3084.228942764309, 3929.528456585214, 3974.5627980922077, 3853.6339047790557, 3932.075962148893, 3958.940615890764, 3964.2467931093142, 4032.8790136295956, 3736.4021756518828, 3962.5046869141356, 3970.3250447424007, 4008.3586626139822, 4016.297147999118, 3284.064041748114, 3300.6864347886913, 3303.653116422765, 3328.8335583220983, 3333.4166520858753, 10005.099541041342, 10011.048950349705, 10166.644167454178, 10168.23738219629, 10280.177585793119, 1482.295909443006, 1567.7413226817562, 1567.7648352747065, 1599.3362754456887, 1651.149657926169, 7401.814954626124, 7619.390448764086, 7688.615569221516, 7799.610019499002, 7822.882656760153, 1246.7920767409992, 1262.1732765038914, 1288.4395288049634, 1293.5601895355624, 1321.1676643714495, 49795.75102124502, 51233.23150152751, 52018.47981520174, 52366.738166309304, 52799.47200528022, 5370.301860758076, 5431.0, 5436.510714035756, 5441.047816632074, 5481.945180548143, 6156.138140660311, 6160.7535698571555, 6163.137160797492, 6166.445019948226, 6177.96911015442, 4504.144212599661, 4523.095380923828, 4564.612007979293, 4585.128825523207, 4597.218472859622, 4585.151746926829, 4792.496787837296, 4842.4189097308545, 4879.146149423907, 4893.241547560134, 2244.1920908472935, 2345.4370950971643, 2381.129770082416, 2392.7607239275935, 2392.79661228794, 824.1346586084587, 832.612835031701, 836.2014276366056, 881.0748713850431, 894.6376717429451, 315.4227763193397, 323.343612466693, 328.3891960952626, 343.75421573575017, 350.96139424663266, 8060.516369017878, 8732.388732788644, 8737.388382813142, 8979.50612716307, 9380.108889655472, 344.8965310406868, 347.83477848022494, 347.89910925831225, 352.1829355894301, 354.024662056034, 4885.560299573055, 4930.334404855299, 4957.628177886673, 5000.524950129732, 5070.062038522885, 466939.0, 480005.0, 486101.0, 487659.0, 491052.0, 60394.39605603975, 62301.37698623046, 62912.37087629156, 63175.6841215791, 63236.683816580626, 375.7125798763948, 376.0392197934304, 376.61397068004965, 377.4319648928345, 379.5805634773591, 8222.301104405953, 8689.17452841979, 8703.303735701254, 8776.078511756174, 8921.0, 30190.396192075597, 30502.237444064074, 30559.0, 30567.08298751041, 30984.0704778857, 39775.80112099421, 40478.0, 41117.0, 41241.38137927873, 41413.0, 4936.259561065869, 5128.435872054146, 5154.561862241751, 5163.793448262178, 5177.0, 8682.956585217033, 9030.683926062557, 9126.0, 9127.452352858849, 9190.954045229731, 7705.961470192613, 7913.485623434458, 7928.524288542706, 8031.919680803351, 8048.154943730824, 6991.161060672548, 7655.272749088827, 7666.655000525101, 7801.765947021599, 8043.19568043191, 7205.459590530836, 8030.116687164291, 8094.87857682147, 8117.0, 8122.796930076795, 5096.796128154981, 5102.183650615883, 5104.132297509506, 5106.7701953412925, 5164.561012313995, 7577.242275772379, 7778.88331675014, 7875.212478752079, 7920.603969801602, 8040.879386809085], "dojo.html": [2672.572388417853, 2755.9035433759823, 2770.5290100682882, 2785.9831161626, 2795.874185661646, 4592.885177870551, 4620.745858977755, 4635.142498637754, 4643.210654188788, 4644.164050470914, 4591.724496530211, 4627.652926030544, 4637.003044345473, 4677.719336839792, 4686.062787442516, 4114.609112134357, 4187.727797693148, 4256.59562341577, 4274.230638485072, 4278.957210427902, 4090.7954602269915, 4127.133302006582, 4202.642775364083, 4320.783960801963, 4333.414988976479, 4213.346931225649, 4228.365745138223, 4235.3646952957, 4280.229558679436, 4290.678199135062, 4228.281192197303, 4251.44731184944, 4304.418903448026, 4349.478062632473, 4408.272635015219, 4072.1041370898356, 4114.958850411517, 4143.295639741251, 4161.646260067898, 4167.83328666853, 4491.101779644085, 4493.932591011137, 4499.550044995507, 4520.299353600197, 4538.478075021382, 4861.416630004422, 4875.658703890729, 4884.413870335582, 4894.902101957941, 4894.99652571222, 4732.124556956974, 4811.302361157613, 4836.22620380741, 4932.087563800673, 5093.414257360414, 4675.766211689436, 4701.224297990793, 4727.2436410174205, 4732.361131247307, 4755.595774359149, 5007.924881126786, 5121.28302037715, 5125.436202017775, 5136.126858434075, 5160.587153027749, 4593.563611456906, 4738.028704115648, 4744.525547445228, 4782.736949467743, 4893.0, 5023.598112151019, 5078.415982162099, 5102.056119617882, 5115.386153661584, 5124.461931497213, 4984.028114517707, 5009.24861270805, 5021.347224860745, 5030.0694371541385, 5040.722760248222, 4489.932651010237, 4762.261849413347, 4799.352087468217, 4856.0, 4933.28467372229, 3815.4849095372324, 3872.1868407634147, 3875.476810630585, 3897.0, 3903.2388684206308, 3321.186309354224, 3512.1570823002294, 3523.806190659487, 3528.770629909048, 3535.151563624763, 4450.643948484114, 4455.77721113943, 4474.418325617649, 4597.149527337453, 4616.192166370872, 5040.0, 5054.646174767731, 5060.746962651852, 5068.062408454448, 5081.949180508148, 4398.890027749268, 4594.95405045952, 4599.72401655895, 4631.282151266559, 4663.836765713184, 4217.578242175758, 4228.9788551057045, 4232.957670423257, 4274.465691788527, 4281.636060934793, 4956.801727930914, 4963.081829861487, 4979.950200497949, 4988.251762235694, 4993.375828021497, 4723.0, 4953.826616068421, 4970.975145124251, 4986.700797951989, 5000.64995450315, 4761.047790441856, 4816.975915120402, 4860.586850117779, 4890.682105663121, 4892.119418504561, 4948.604111670986, 4978.775955082103, 4997.675151115166, 5020.121478741279, 5035.92446113316, 4426.291793313055, 4998.0, 5002.199648056294, 5019.899602008012, 5042.193249080129, 4783.808647654055, 4864.854054378375, 4871.147549178951, 4898.706077635211, 4898.730569818694, 4790.7365094920115, 4817.253325734517, 4822.8794280143275, 4827.8551643450755, 4848.3454733610515, 4529.705569137996, 4740.715557066587, 4753.881152971203, 4765.833195838129, 4777.689450185727, 4720.268358404453, 4733.431988161443, 4744.644151688568, 4810.230363141881, 4879.707217566957, 4745.620350372031, 4752.097101550694, 4772.141014617402, 4794.993051459232, 4864.854054378375], "mootools.html": [698.8427603789145, 1259.106034715352, 1299.499692618342, 1326.9867301326983, 1571.1358752686026, 6133.478654314383, 6318.652474113922, 6536.83657908552, 6638.568493047948, 6705.664716764167, 6620.834479138024, 6738.595684258948, 6770.796876093713, 6808.795736127924, 6815.5569887957245, 1826.6255417639352, 1833.8899666020016, 1857.6749068912954, 1857.7213417987343, 1860.0327829528637, 1868.841148502379, 1896.7249748786417, 1903.9809601904012, 1911.665458544749, 1914.6840771272794, 1895.9715604265948, 1898.3355825461117, 1901.6006638605909, 1906.8379187769056, 1921.164293532311, 1843.7050071988485, 1872.447627949758, 1872.9344472943449, 1873.072828949665, 1877.5681593233496, 1841.7237414387814, 1882.265916292647, 1885.7359969604267, 1900.1354383755358, 1901.7622797150357, 5920.082387229986, 6632.502562307798, 6655.401013908723, 6660.134182556285, 6672.165979252593, 3633.055405594538, 3875.806209689504, 3941.034446560611, 3951.5060617422823, 3965.504311961005, 2311.722593288816, 2421.0799896039393, 2427.7936375408112, 2430.890609922558, 2461.8276720629565, 629.5530173576766, 694.2086021934998, 732.3518685962908, 740.104473586955, 741.7997140771961, 8703.52130632815, 8710.738677839676, 8729.912700872974, 8818.11818818113, 8874.334424918157, 3422.281320922634, 3531.94702079469, 3536.4341705327024, 3564.108972756811, 3568.125809176768, 7132.893006604905, 7265.636718164071, 7290.45321600882, 7381.114266287972, 7424.443166762514, 3995.081131339808, 3995.5405128410025, 4004.279229738675, 4009.8195581198333, 4046.7976601169826, 3695.722820788452, 3711.03513086594, 3738.420544815558, 3743.6069212732814, 3770.698344132463, 2729.56326987681, 2760.213339198319, 2767.405007923266, 2797.53840616296, 2820.605115283862, 878.7890906182598, 890.2299510923134, 894.879191309165, 897.6095398501673, 901.4050726520466, 1034.4207243943265, 1050.1651187305956, 1050.4747626186906, 1078.5254488025244, 1117.3910218930703, 6215.098810672427, 6231.065340199007, 6232.189815323979, 6249.406306400884, 6250.937490625127, 364.4078372644453, 371.34828376200136, 373.8411175250508, 373.8747519580971, 374.2048147686167, 4873.049755297754, 4918.680285781485, 4944.98627781304, 4945.604351651859, 5003.049420610072, 7776.494527855672, 7777.922220777833, 7950.403719721044, 7982.560959147303, 8003.439759216915, 7929.286364227132, 7979.72070977513, 8001.239882211181, 8007.399445041645, 8008.519488830689, 5443.8094666686475, 5535.446455354432, 6333.36666333363, 6370.171877655967, 6382.617042977344, 5927.31835838884, 6110.419510146529, 6160.537959652955, 6160.815175544741, 6219.160413344322, 6544.509161812978, 6699.698513566804, 7212.062431884031, 7212.855742885218, 7225.530340527849, 7067.081279433641, 7275.563466192046, 7288.271172882882, 7344.118705755343, 7366.410687145123, 5244.580433565229, 5290.65610735301, 5316.043112239679, 5341.412444631165, 5365.114756065362, 5873.4126587340925, 5961.046232602763, 5979.222701048836, 5997.970010149921, 6014.9097763534455, 5575.080111781511, 5586.190002449541, 5615.691136987505, 5653.265075540318, 5666.206731057573, 5468.507834294933, 5470.234167216672, 5565.1374037024325, 5580.190872323409, 5587.273654424899, 5600.635958662674, 5652.604317697722, 5676.0, 5694.430556944272, 5731.168980497888, 5010.148274793367, 5032.6225533084435, 5048.040872234411, 5056.62075344358, 5061.595072394273, 5077.416097148875, 5089.567386772166, 5105.591552675703, 5131.794728210979, 5152.098382782923], "ext.html": [485.59210263378753, 488.479769045966, 492.30093267560085, 497.9667190579546, 518.6343627742442, 27333.316667083334, 28579.142625721237, 33582.49626255608, 34103.0, 34607.134821629406, 36262.0, 36777.26445471096, 36841.44737828928, 36916.26167476649, 37354.0, 7118.1458225013075, 7679.155292917774, 7787.805304867367, 7844.568548729818, 7888.960555197216, 7275.090613673291, 9312.8603070954, 9474.384165029285, 9508.096730810563, 9538.141567258945, 9257.6296948122, 9276.768080798, 9350.298727595458, 9393.577289021976, 9436.669716559922, 7344.4491663124945, 7603.4297427693145, 9050.592723327467, 9284.071592840695, 9439.38643988142, 8931.0, 9017.729468115902, 9039.096090390974, 9049.864252036225, 9104.180623743829, 33519.16202094967, 33921.49117763236, 33971.49042764361, 34215.31569368599, 34223.315533689434, 2532.240327901622, 2544.9236522904343, 2744.3687951771003, 2912.2573743695434, 3124.875004999797, 23452.7654723454, 24342.756572434402, 24787.13245036433, 25093.874530627414, 25504.8724756375, 1928.9562524273813, 1979.712941623471, 1999.4701404127918, 2005.1177481907914, 2049.7540295164526, 219445.0, 220494.0, 221946.9999999984, 222175.0, 223078.0, 47566.524334756905, 52207.0, 52601.73699131556, 52673.47326526685, 52766.99999999923, 44328.335074973904, 56243.0, 57551.42448575461, 57736.4226357731, 58257.0, 14182.0, 14541.636459088608, 14552.49066282675, 14562.27188640585, 14569.0, 11040.116790656728, 11128.944355278334, 11162.944185279022, 11165.38590377537, 11173.0, 17540.561485962953, 17650.382236621655, 17653.646927061385, 17844.821551784575, 17871.73192402115, 7191.496595238283, 7417.8145546361775, 7430.517016394026, 7498.700051997859, 7513.549187048795, 796.8366484870587, 823.9217274358926, 844.6241422566899, 946.6592026870321, 999.0259496990376, 24085.879570602036, 24257.39356516101, 24421.633675494882, 24566.263012109666, 24585.631215531783, 896.462122726359, 899.50077706872, 1004.6232662751469, 1045.9895401046044, 1069.3209811769582, 12707.428165732565, 12794.744105117845, 12815.487380504675, 12929.482820687068, 12982.285974271317, 280546.0, 283197.0, 285477.0, 285841.0, 285946.0, 40432.0, 41737.58262417398, 44645.77677111659, 46226.768866156126, 47416.7629161852, 1185.5613423033533, 1187.5724739093919, 1209.1777591237867, 1212.0, 1245.4520011195045, 21974.121035158416, 22995.6550651737, 23080.192193273157, 23316.65025024592, 23597.410064748517, 37413.25173496569, 37902.052448689006, 42221.577784222995, 42874.14251714886, 42898.571014290705, 164190.179049104, 165391.0, 167004.0, 168229.0, 168369.0, 24629.876850615634, 25738.35654108662, 26753.19740407791, 26795.464090717687, 27543.862280688467, 34706.132346691535, 35242.295154097286, 36265.637343627284, 36771.44842827306, 36876.631233687316, 29913.551296730133, 30487.237819054702, 31325.686743132275, 34375.82812085924, 34446.31107377889, 30698.232544186572, 31216.53175202419, 31231.063068107993, 31647.683523164473, 33328.33343333168, 32403.837980809945, 32779.18052048718, 33174.336513270086, 33241.66758332482, 33467.83266083654, 33670.49494257539, 34052.65947340594, 34412.0, 34696.479552806224, 34791.4781278276, 26663.733362666124, 27319.72680273251, 28747.425051498434, 28896.0, 29281.41437171287], "prototype.html": [276.84496681858155, 282.30975265475905, 283.3482989125013, 286.26144547068566, 290.73543075801, 5077.974610126954, 5158.716270605115, 5199.116150254456, 5202.089634313998, 5203.76583053763, 4949.505049495057, 4965.056639238542, 5006.674566153198, 5059.848204553869, 5117.948820511794, 3861.131245469761, 3888.0862997195777, 3889.1638297765976, 3900.492935918334, 3901.3757798752204, 3732.9066773330615, 3901.08324543732, 3904.141088960424, 3926.430667553203, 3946.3291240489184, 3772.509573755408, 3809.0, 3877.8448862045484, 3879.3405121129476, 3922.17634296798, 3844.000559854444, 3850.5186851643543, 3859.4210868369687, 3875.379939209713, 3911.550171730245, 3329.4839299908554, 3340.7160391366765, 3345.3643807676463, 3357.5803024621923, 3383.729301655886, 4970.726610036447, 4991.401031876198, 5001.324821149135, 5038.168702164138, 5056.772445239973, 3977.105151340954, 4207.0954744729725, 4252.298370768819, 4294.71158652403, 4383.3424986252, 5210.348706411699, 5216.556592689626, 5274.182501712203, 5328.120860058125, 5363.410024897258, 3588.0, 3589.0, 3635.1820840310984, 3650.945235821465, 3677.9816100919325, 5549.889002219933, 5593.52455041322, 5604.523615492729, 5680.630759000693, 5686.601937864351, 3598.0824889653495, 3599.3701102307514, 3613.33153366628, 3656.963430365662, 3661.56061272649, 3582.570091588974, 3653.707703383723, 3668.248009158116, 3685.1155722626377, 3716.368217402994, 4247.830086796494, 4288.5711428857485, 4309.806058727365, 4314.22343978087, 4343.978280108579, 4730.692504987165, 5157.716325602053, 5266.420693723688, 5357.732113394315, 5436.782528698887, 1342.0471465259775, 1360.9591712248648, 1362.8909687224998, 1364.467857535562, 1367.931603419845, 860.6987554355925, 869.4044579463088, 884.0717246890739, 890.470170248701, 894.7584152278848, 5049.747512624354, 5056.469070747592, 5064.164412871834, 5071.0872043032605, 5079.492050794891, 5577.749001294951, 5625.943740562542, 5629.549636029108, 5632.52123569493, 5668.036433806263, 5097.0, 5118.360204974379, 5124.743762811844, 5154.3814742230425, 5161.612879034087, 3011.909642710722, 3081.3837232553133, 3092.196029032468, 3103.5655008298854, 3108.424941385851, 5642.351129620064, 5652.208690783294, 5660.773569057274, 5678.176664383641, 5732.254806875163, 5723.399043100415, 5736.254286942754, 5741.540676745851, 5769.798057067983, 5801.7389217485315, 5640.210370548045, 5653.265075540154, 5653.321601407857, 5687.260656114679, 5710.400407957188, 5451.018816613047, 5677.120046392815, 5700.771969121189, 5717.22817419643, 5724.627899186539, 5557.694326812064, 5566.721663916869, 5580.665160090408, 5636.182753500638, 5636.985342638364, 5724.971375143097, 5732.570057245806, 5769.0, 5810.389909059488, 5857.853553661193, 3527.5237842890883, 3578.5884623267616, 3592.1738000260607, 3621.420572708354, 3636.036450340715, 5404.459554044722, 5557.694326812064, 5619.241402410622, 5632.971835140798, 5651.378348381592, 5349.545288650353, 5404.837854864203, 5423.566114710892, 5502.9174562382395, 5536.474034966672, 5390.730463476732, 5390.946090539044, 5398.595105367034, 5425.267588875609, 5490.258815060076, 5270.7101109439345, 5279.234510995961, 5301.5493683037375, 5356.758945847524, 5384.407715151408, 5345.1714984177515, 5434.076207044733, 5436.537894278872, 5437.40188579248, 5516.558675306046, 5324.254604355316, 5351.036813373475, 5381.757820898148, 5397.703126327932, 5406.0], "yui.html": [528.5797790756349, 577.3360635269441, 603.5202014398553, 653.637231336608, 657.1949362031511, 11632.418379081044, 11795.056395488351, 11811.645650630495, 11886.167968242227, 11923.403829808507, 11868.287902725842, 12127.696807579792, 12175.939120304387, 12258.141930064876, 12381.0, 614.3395849461824, 762.2111114995994, 776.5651235308218, 777.0558771093121, 783.6904422753009, 620.8820324138422, 623.6476390839184, 762.4472257613241, 779.1390513482605, 779.1974266505508, 790.0519376747897, 799.9640016199256, 801.5471258738794, 802.3380710913491, 810.6514198894473, 627.5732501898707, 640.5196102922808, 793.714262865368, 797.9521228726295, 799.588212070784, 569.7066011004337, 571.5085026876883, 572.3761100400583, 576.7318197038397, 579.8086631411624, 11336.149788765875, 11616.0, 11767.646970590897, 11779.469923853361, 11790.115741319349, 7867.921320786833, 8149.837003259901, 8233.0, 8302.879111319955, 8309.545829479817, 7588.317051465395, 7812.765617031441, 7973.32226760726, 8010.919890801076, 8127.878081828718, 2430.647556104355, 2451.497443024176, 2479.3925488255495, 2526.772590466867, 2558.9360265993314, 39681.80159099186, 39876.60123398758, 40000.0, 40265.0, 40441.39337909934, 5529.474699903502, 5538.0, 5547.55619550435, 5574.749136288877, 5758.539316854725, 9261.49061801594, 9272.119148680864, 9294.953525232331, 9353.0, 9391.530423478798, 5189.221616757516, 5328.3605967284175, 5362.249285100089, 5483.670979741229, 5559.221708960748, 2975.6577993531023, 3043.4978228592036, 3063.739582135499, 3117.703818137273, 3202.1834432219634, 2276.7040284762875, 2300.0454811253144, 2304.297189357262, 2308.434433563754, 2312.040503191157, 323.4178478738262, 324.83433448941213, 327.43680868905443, 331.25137189950885, 334.8175244491758, 466.153930615931, 473.8838984448832, 491.6817206869627, 510.48696060459, 511.7671459485925, 6471.288158302583, 6654.83362915931, 6748.358905903931, 6803.965980170067, 6905.516613837083, 357.7960562479362, 374.5019124564323, 441.17059927337044, 498.7281931347424, 508.43309709674185, 3124.2345625321486, 3160.925285402974, 3208.7272581830807, 3256.316173603522, 3291.1772056985756, 51500.48499514957, 52218.47781522136, 52409.0, 52673.47326526685, 52702.47297526975, 43324.783376082916, 43998.12003759907, 44113.77943110328, 44395.334069988974, 44432.0, 39773.40339894904, 39935.60064399319, 40178.1964360717, 40704.3894341591, 40883.7955810225, 6886.758963436256, 6898.793036208922, 7066.681999309941, 7215.67529461186, 7389.408847292097, 28817.42365152727, 28821.855890720413, 29372.85313573504, 29746.405071898007, 30066.248343790707, 39855.2028959425, 40059.399109012804, 40357.798211008754, 40408.1918361637, 40683.0, 6131.448169664752, 6415.550911436155, 6532.8366790830605, 6616.172978377703, 6632.635205063768, 9455.763605909631, 9552.95223523878, 9655.758606034624, 9657.034296570288, 9726.805463890823, 9062.093790620886, 9183.67857125024, 9189.862152067859, 9190.080991900757, 9220.861687074834, 9162.58768355439, 9167.724968250963, 9176.541172941459, 9182.17360437564, 9228.40015398997, 8997.190252877272, 9067.591958361758, 9074.092590740873, 9083.18251357381, 9122.726318210463, 7594.696212151452, 7604.201558836243, 7836.490628109154, 8057.153998830038, 8093.988251468566, 7757.0, 7864.095629002509, 7865.252800983897, 7914.2085791420395, 8133.79665508367]}, "summary": {"suite": 5529.050007277694, "subtests": {"jquery.html": {"filtered": 5443.356500397892, "value": 5443.356500397892}, "dojo.html": {"filtered": 4552.239830911759, "value": 4552.239830911759}, "mootools.html": {"filtered": 3587.8900224947847, "value": 3587.8900224947847}, "ext.html": {"filtered": 16199.994643287466, "value": 16199.994643287466}, "prototype.html": {"filtered": 4031.9223561064164, "value": 4031.9223561064164}, "yui.html": {"filtered": 4919.231990906434, "value": 4919.231990906434}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0021"}, "testrun": {"date": 1447433652, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151113004332", "branch": "Mozilla-Aurora", "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59"}}, {"talos_counters": {}, "results": {"audio-dft": [189.0, 197.0, 197.0, 187.0, 187.0, 192.0, 196.0, 193.0, 189.0, 187.0], "ai-astar": [126.0, 128.0, 132.0, 132.0, 126.0, 127.0, 140.0, 134.0, 132.0, 127.0], "imaging-gaussian-blur": [149.0, 149.0, 137.0, 136.0, 141.0, 148.0, 136.0, 149.0, 149.0, 138.0], "audio-beat-detection": [185.0, 156.0, 196.0, 185.0, 154.0, 178.0, 152.0, 191.0, 181.0, 152.0], "json-stringify-tinderbox": [71.0, 75.0, 75.0, 80.0, 82.0, 79.0, 80.0, 79.0, 80.0, 79.0], "stanford-crypto-pbkdf2": [170.0, 163.0, 178.0, 177.0, 172.0, 156.0, 170.0, 176.0, 177.0, 174.0], "json-parse-financial": [64.0, 73.0, 74.0, 74.0, 78.0, 76.0, 77.0, 85.0, 67.0, 66.0], "stanford-crypto-sha256-iterative": [79.0, 80.0, 83.0, 84.0, 84.0, 83.0, 84.0, 83.0, 79.0, 80.0], "audio-fft": [94.0, 94.0, 95.0, 146.0, 81.0, 85.0, 85.0, 85.0, 134.0, 75.0], "imaging-darkroom": [153.0, 154.0, 150.0, 147.0, 154.0, 153.0, 150.0, 146.0, 153.0, 152.0], "stanford-crypto-ccm": [148.0, 158.0, 156.0, 148.0, 153.0, 157.0, 145.0, 152.0, 149.0, 149.0], "audio-oscillator": [116.0, 116.0, 166.0, 106.0, 109.0, 112.0, 153.0, 102.0, 103.0, 155.0], "stanford-crypto-aes": [94.0, 99.0, 100.0, 99.0, 99.0, 100.0, 101.0, 100.0, 96.0, 100.0], "imaging-desaturate": [122.0, 124.0, 124.0, 122.0, 119.0, 118.0, 122.0, 124.0, 124.0, 124.0]}, "summary": {"suite": 1787.6, "subtests": {"audio-fft": {"filtered": 97.4, "value": 97.4}, "stanford-crypto-pbkdf2": {"filtered": 171.3, "value": 171.3}, "audio-beat-detection": {"filtered": 173.0, "value": 173.0}, "stanford-crypto-ccm": {"filtered": 151.5, "value": 151.5}, "imaging-darkroom": {"filtered": 151.2, "value": 151.2}, "json-parse-financial": {"filtered": 73.4, "value": 73.4}, "audio-oscillator": {"filtered": 123.8, "value": 123.8}, "ai-astar": {"filtered": 130.4, "value": 130.4}, "audio-dft": {"filtered": 191.4, "value": 191.4}, "stanford-crypto-sha256-iterative": {"filtered": 81.9, "value": 81.9}, "json-stringify-tinderbox": {"filtered": 78.0, "value": 78.0}, "imaging-gaussian-blur": {"filtered": 143.2, "value": 143.2}, "stanford-crypto-aes": {"filtered": 98.8, "value": 98.8}, "imaging-desaturate": {"filtered": 122.3, "value": 122.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0021"}, "testrun": {"date": 1447433652, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151113004332", "branch": "Mozilla-Aurora", "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59"}}, {"talos_counters": {}, "results": {"DeltaBlue": [228.83295194508008], "Encrypt": [376.3643206624012], "NavierStokes": [6869.86301369863], "Decrypt": [6823.1292517006805], "Splay": [680.7351940095303], "Richards": [196.23233908948194], "RegExp": [34322.03389830508], "Earley": [811.0300081103001], "Boyer": [14652.173913043478], "RayTrace": [1236.0939431396787]}, "summary": {"suite": 17241.33727301284, "subtests": {"DeltaBlue": {"filtered": 288.9356599999999, "value": 288.9356599999999}, "Encrypt": {"filtered": 707.2429169999999, "value": 707.2429169999999}, "NavierStokes": {"filtered": 216.01595214356922, "value": 216.01595214356922}, "Decrypt": {"filtered": 39.01157228315055, "value": 39.01157228315055}, "Splay": {"filtered": 119.71027900000001, "value": 119.71027900000001}, "RegExp": {"filtered": 26.54227901234567, "value": 26.54227901234567}, "Richards": {"filtered": 179.89899200000005, "value": 179.89899200000005}, "Earley": {"filtered": 821.7488789999996, "value": 821.7488789999996}, "Boyer": {"filtered": 45.48560534124626, "value": 45.48560534124626}, "RayTrace": {"filtered": 598.6511009999998, "value": 598.6511009999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0021"}, "testrun": {"date": 1447433652, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151113004332", "branch": "Mozilla-Aurora", "revision": "4b6161cc379b78e4fef8195c3f62a1603acf7b59"}}] 09:14:30 INFO - RETURN: dromaeo_css: 5529.05 09:14:30 INFO - RETURN: kraken: 1787.60 09:14:30 INFO - RETURN: v8_7: 17241.34 09:14:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17241.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1787.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5529.05"}}} 09:14:30 INFO - Return code: 0 09:14:30 INFO - # TBPL SUCCESS # 09:14:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:30 INFO - 2015-11-13 09:14:30.122 screenresolution[1947:10489] starting screenresolution argv=screenresolution get 09:14:30 INFO - 2015-11-13 09:14:30.126 screenresolution[1947:10489] Display 0: 1600x1200x32@60 09:14:30 INFO - 2015-11-13 09:14:30.132 screenresolution[1948:10492] starting screenresolution argv=screenresolution list 09:14:30 INFO - Available Modes on Display 0 09:14:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:30 INFO - Intel HD Graphics 3000: 09:14:30 INFO - Chipset Model: Intel HD Graphics 3000 09:14:30 INFO - Type: GPU 09:14:30 INFO - Bus: Built-In 09:14:30 INFO - VRAM (Total): 512 MB 09:14:30 INFO - VRAM (Dynamic, Max): 10 09:14:30 INFO - Vendor: Intel (0x8086) 09:14:30 INFO - Device ID: 0x0116 09:14:30 INFO - Revision ID: 0x0009 09:14:30 INFO - Displays: 09:14:30 INFO - Display: 09:14:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:30 INFO - Display Serial Number: 1600x1200 60 09:14:30 INFO - Main Display: Yes 09:14:30 INFO - Mirror: Off 09:14:30 INFO - Online: Yes 09:14:30 INFO - Rotation: Supported 09:14:30 INFO - Return code: 0 09:14:30 INFO - Running post-action listener: _resource_record_post_action 09:14:30 INFO - Running post-run listener: _resource_record_post_run 09:14:31 INFO - Total resource usage - Wall time: 1261s; CPU: 30.0%; Read bytes: 37938176; Write bytes: 688401408; Read time: 4071; Write time: 47667 09:14:31 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 339716608; Write bytes: 336220160; Read time: 37199; Write time: 6382 09:14:31 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 36799488; Write bytes: 342035456; Read time: 3863; Write time: 40638 09:14:31 INFO - Running post-run listener: _upload_blobber_files 09:14:31 INFO - Blob upload gear active. 09:14:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:14:31 INFO - Copying logs to upload dir... 09:14:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.998786 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-13 09:14:31.574780) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 09:14:31.578057) ========= 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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011081 build_url: 'https://queue.taskcluster.net/v1/task/jjogNFO1RGeqr8pk2M5W-w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 09:14:31.606423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 09:14:31.606840) ========= 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.BfhMuR6G0e/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.h2MO1mIFIn/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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.005752 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 09:14:31.660399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 09:14:31.661220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 09:14:31.662142) ========= ========= Total master_lag: 0.80 =========