builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0031 starttime: 1448280935.37 results: success (0) buildid: 20151123032726 builduid: ae02b6d35b064c7ea3e2a9eeb74d8545 revision: 79c9f80eeeb878601c2a9d01a805cda47dfede1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.368705) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.369165) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.369442) ========= 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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.005554 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.430445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.430822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.706280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.706631) ========= 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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.005462 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.773351) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.776668) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.777008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:35.777280) ========= 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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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-23 04:15: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.102, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-23 04:15:36 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.332614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:36.124317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:36.127691) ========= 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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.020152 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:36.186387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:15:36.186750) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79c9f80eeeb878601c2a9d01a805cda47dfede1f --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 79c9f80eeeb878601c2a9d01a805cda47dfede1f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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-23 04:15:36,258 truncating revision to first 12 chars 2015-11-23 04:15:36,258 Setting DEBUG logging. 2015-11-23 04:15:36,258 attempt 1/10 2015-11-23 04:15:36,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/79c9f80eeeb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 04:15:37,115 unpacking tar archive at: mozilla-aurora-79c9f80eeeb8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.105861 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:15:37.305399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:37.305705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:37.315308) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:37.315656) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:15:37.316061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-23 04:15:37.316333) ========= /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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:15:37 INFO - MultiFileLogger online at 20151123 04:15:37 in /builds/slave/test 04:15:37 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 04:15:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:15:37 INFO - {'append_to_log': False, 04:15:37 INFO - 'base_work_dir': '/builds/slave/test', 04:15:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:15:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:15:37 INFO - 'branch': 'Mozilla-Aurora', 04:15:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:37 INFO - 'config_files': ('talos/mac_config.py',), 04:15:37 INFO - 'default_actions': ('clobber', 04:15:37 INFO - 'read-buildbot-config', 04:15:37 INFO - 'download-and-extract', 04:15:37 INFO - 'populate-webroot', 04:15:37 INFO - 'create-virtualenv', 04:15:37 INFO - 'install', 04:15:37 INFO - 'run-tests'), 04:15:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:37 INFO - 'download_minidump_stackwalk': True, 04:15:37 INFO - 'download_symbols': 'ondemand', 04:15:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:37 INFO - 'installer_path': 'installer.exe', 04:15:37 INFO - 'log_level': 'info', 04:15:37 INFO - 'log_name': 'talos', 04:15:37 INFO - 'log_to_console': True, 04:15:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:15:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:15:37 INFO - 'opt_config_files': (), 04:15:37 INFO - 'pip_index': False, 04:15:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:15:37 INFO - 'cmd': ('bash', 04:15:37 INFO - '-c', 04:15:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:15:37 INFO - 'enabled': True, 04:15:37 INFO - 'halt_on_failure': False, 04:15:37 INFO - 'name': 'check_screen_resolution'},), 04:15:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:15:37 INFO - 'cmd': ('bash', 04:15:37 INFO - '-c', 04:15:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:15:37 INFO - 'enabled': True, 04:15:37 INFO - 'halt_on_failure': False, 04:15:37 INFO - 'name': 'check_screen_resolution'},), 04:15:37 INFO - 'run_cmd_checks_enabled': True, 04:15:37 INFO - 'sps_profile': False, 04:15:37 INFO - 'sps_profile_interval': 0, 04:15:37 INFO - 'suite': 'dromaeojs', 04:15:37 INFO - 'system_bits': '64', 04:15:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:37 INFO - 'title': 't-yosemite-r5-0031', 04:15:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:37 INFO - 'use_talos_json': True, 04:15:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:15:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:37 INFO - 'work_dir': 'build'} 04:15:37 INFO - ##### 04:15:37 INFO - ##### Running clobber step. 04:15:37 INFO - ##### 04:15:37 INFO - Running pre-action listener: _resource_record_pre_action 04:15:37 INFO - Running main action method: clobber 04:15:37 INFO - rmtree: /builds/slave/test/build 04:15:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:15:39 INFO - Running post-action listener: _resource_record_post_action 04:15:39 INFO - ##### 04:15:39 INFO - ##### Running read-buildbot-config step. 04:15:39 INFO - ##### 04:15:39 INFO - Running pre-action listener: _resource_record_pre_action 04:15:39 INFO - Running main action method: read_buildbot_config 04:15:39 INFO - Using buildbot properties: 04:15:39 INFO - { 04:15:39 INFO - "properties": { 04:15:39 INFO - "buildnumber": 434, 04:15:39 INFO - "product": "firefox", 04:15:39 INFO - "script_repo_revision": "production", 04:15:39 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 04:15:39 INFO - "repository": "", 04:15:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 04:15:39 INFO - "buildid": "20151123032726", 04:15:39 INFO - "slavename": "t-yosemite-r5-0031", 04:15:39 INFO - "pgo_build": "False", 04:15:39 INFO - "basedir": "/builds/slave/test", 04:15:39 INFO - "project": "", 04:15:39 INFO - "platform": "yosemite", 04:15:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:15:39 INFO - "slavebuilddir": "test", 04:15:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:15:39 INFO - "branch": "mozilla-aurora", 04:15:39 INFO - "repo_path": "releases/mozilla-aurora", 04:15:39 INFO - "stage_platform": "macosx64", 04:15:39 INFO - "builduid": "ae02b6d35b064c7ea3e2a9eeb74d8545", 04:15:39 INFO - "revision": "79c9f80eeeb878601c2a9d01a805cda47dfede1f" 04:15:39 INFO - }, 04:15:39 INFO - "sourcestamp": { 04:15:39 INFO - "repository": "", 04:15:39 INFO - "hasPatch": false, 04:15:39 INFO - "project": "", 04:15:39 INFO - "branch": "mozilla-aurora-macosx64-talos", 04:15:39 INFO - "changes": [ 04:15:39 INFO - { 04:15:39 INFO - "category": null, 04:15:39 INFO - "files": [ 04:15:39 INFO - { 04:15:39 INFO - "url": null, 04:15:39 INFO - "name": "https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 04:15:39 INFO - } 04:15:39 INFO - ], 04:15:39 INFO - "repository": "", 04:15:39 INFO - "rev": "79c9f80eeeb878601c2a9d01a805cda47dfede1f", 04:15:39 INFO - "who": "cbook@mozilla.com", 04:15:39 INFO - "when": 1448280925, 04:15:39 INFO - "number": 6694606, 04:15:39 INFO - "comments": "Bug 1225250 - fix stride on SourceSurfaceSkia when initialized from GPU texture. r=jmuizelaar, a=lizzard", 04:15:39 INFO - "project": "", 04:15:39 INFO - "at": "Mon 23 Nov 2015 04:15:25", 04:15:39 INFO - "branch": "mozilla-aurora-macosx64-talos", 04:15:39 INFO - "revlink": "", 04:15:39 INFO - "properties": [ 04:15:39 INFO - [ 04:15:39 INFO - "buildid", 04:15:39 INFO - "20151123032726", 04:15:39 INFO - "Change" 04:15:39 INFO - ], 04:15:39 INFO - [ 04:15:39 INFO - "builduid", 04:15:39 INFO - "ae02b6d35b064c7ea3e2a9eeb74d8545", 04:15:39 INFO - "Change" 04:15:39 INFO - ], 04:15:39 INFO - [ 04:15:39 INFO - "pgo_build", 04:15:39 INFO - "False", 04:15:39 INFO - "Change" 04:15:39 INFO - ] 04:15:39 INFO - ], 04:15:39 INFO - "revision": "79c9f80eeeb878601c2a9d01a805cda47dfede1f" 04:15:39 INFO - } 04:15:39 INFO - ], 04:15:39 INFO - "revision": "79c9f80eeeb878601c2a9d01a805cda47dfede1f" 04:15:39 INFO - } 04:15:39 INFO - } 04:15:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 04:15:39 INFO - Running post-action listener: _resource_record_post_action 04:15:39 INFO - ##### 04:15:39 INFO - ##### Running download-and-extract step. 04:15:39 INFO - ##### 04:15:39 INFO - Running pre-action listener: _resource_record_pre_action 04:15:39 INFO - Running main action method: download_and_extract 04:15:39 INFO - mkdir: /builds/slave/test/build/tests 04:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:39 INFO - https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/test_packages.json 04:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/test_packages.json 04:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:15:43 INFO - Downloaded 1149 bytes. 04:15:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:15:43 INFO - Using the following test package requirements: 04:15:43 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:15:43 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 04:15:43 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'jsshell-mac.zip'], 04:15:43 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 04:15:43 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:15:43 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 04:15:43 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 04:15:43 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 04:15:43 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:15:43 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:15:43 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 04:15:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:15: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')]} 04:15:43 INFO - https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:15:45 INFO - Downloaded 17447932 bytes. 04:15:45 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 04:15:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:15:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 04:15:51 INFO - Return code: 0 04:15:51 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 04:15: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')]} 04:15:51 INFO - https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:15:55 INFO - Downloaded 17447932 bytes. 04:15:55 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 04:15:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:15:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 04:16:01 INFO - Return code: 0 04:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:01 INFO - https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:16:02 INFO - Downloaded 11131307 bytes. 04:16:02 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 04:16:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:16:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:16:02 INFO - Return code: 0 04:16: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')]} 04:16:02 INFO - https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 04:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 04:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:16:07 INFO - Downloaded 107796543 bytes. 04:16:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:16:07 INFO - mkdir: /builds/slave/test/properties 04:16:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:07 INFO - Contents: 04:16:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:16:07 INFO - Running post-action listener: _resource_record_post_action 04:16:07 INFO - Running post-action listener: set_extra_try_arguments 04:16:07 INFO - ##### 04:16:07 INFO - ##### Running populate-webroot step. 04:16:07 INFO - ##### 04:16:07 INFO - Running pre-action listener: _resource_record_pre_action 04:16:07 INFO - Running main action method: populate_webroot 04:16:07 INFO - Guessing talos json url... 04:16: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')]} 04:16:07 INFO - https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 04:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 04:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 04:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 04:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Odf3n8isQXSbBgKfuWHJkQ/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 04:16:08 INFO - Downloaded 107 bytes. 04:16:08 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 04:16:08 INFO - Contents: 04:16:08 INFO - 20151123032726 04:16:08 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/79c9f80eeeb878601c2a9d01a805cda47dfede1f 04:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:08 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/79c9f80eee/testing/talos/talos.json 04:16:08 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/79c9f80eee/testing/talos/talos.json to /builds/slave/test/build/talos.json 04:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/79c9f80eee/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 04:16:09 INFO - Downloaded 4264 bytes. 04:16:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:16:09 INFO - '../fennec_ids.txt'], 04:16:09 INFO - 'tests': ['tcheck2']}, 04:16:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:09 INFO - '--tppagecycles', 04:16:09 INFO - '7'], 04:16:09 INFO - 'tests': ['tsvgm']}}, 04:16:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'tests': ['damp', 'tps']}, 04:16:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['damp', 'tps']}, 04:16:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:09 INFO - 'other': {'tests': ['a11yr', 04:16:09 INFO - 'ts_paint', 04:16:09 INFO - 'tpaint', 04:16:09 INFO - 'sessionrestore', 04:16:09 INFO - 'sessionrestore_no_auto_restore']}, 04:16:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['a11yr', 04:16:09 INFO - 'ts_paint', 04:16:09 INFO - 'tpaint', 04:16:09 INFO - 'sessionrestore', 04:16:09 INFO - 'sessionrestore_no_auto_restore']}, 04:16:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['a11yr', 04:16:09 INFO - 'ts_paint', 04:16:09 INFO - 'tpaint', 04:16:09 INFO - 'sessionrestore', 04:16:09 INFO - 'sessionrestore_no_auto_restore']}, 04:16:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['a11yr', 04:16:09 INFO - 'ts_paint', 04:16:09 INFO - 'tpaint', 04:16:09 INFO - 'sessionrestore', 04:16:09 INFO - 'sessionrestore_no_auto_restore']}, 04:16:09 INFO - 'other_l64': {'tests': ['a11yr', 04:16:09 INFO - 'ts_paint', 04:16:09 INFO - 'tpaint', 04:16:09 INFO - 'sessionrestore', 04:16:09 INFO - 'sessionrestore_no_auto_restore']}, 04:16:09 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:09 INFO - 'ts_paint', 04:16:09 INFO - 'tpaint', 04:16:09 INFO - 'sessionrestore', 04:16:09 INFO - 'sessionrestore_no_auto_restore']}, 04:16:09 INFO - 'svgr': {'tests': ['tsvgx', 04:16:09 INFO - 'tsvgr_opacity', 04:16:09 INFO - 'tart', 04:16:09 INFO - 'tscrollx', 04:16:09 INFO - 'cart']}, 04:16:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['tsvgx', 04:16:09 INFO - 'tsvgr_opacity', 04:16:09 INFO - 'tart', 04:16:09 INFO - 'tscrollx', 04:16:09 INFO - 'cart']}, 04:16:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'tests': ['tp5o']}, 04:16:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'talos_options': ['--e10s'], 04:16:09 INFO - 'tests': ['tp5o']}, 04:16:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'talos_options': ['--xperf_path', 04:16:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:09 INFO - 'tests': ['tp5n']}, 04:16:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:09 INFO - 'talos_options': ['--e10s', 04:16:09 INFO - '--xperf_path', 04:16:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 04:16:09 INFO - 'C:/slave/talos-data/talos/xperf.config'], 04:16:09 INFO - 'tests': ['tp5n']}}, 04:16:09 INFO - 'talos.zip': {'path': '', 04:16:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:09 INFO - Running post-action listener: _resource_record_post_action 04:16:09 INFO - ##### 04:16:09 INFO - ##### Running create-virtualenv step. 04:16:09 INFO - ##### 04:16:09 INFO - Running pre-action listener: _resource_record_pre_action 04:16:09 INFO - Running main action method: create_virtualenv 04:16:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:09 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 04:16:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:09 INFO - Using real prefix '/tools/python27' 04:16:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:14 INFO - Installing pip.................done. 04:16:14 INFO - Return code: 0 04:16:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:14 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')]} 04:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:14 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')]} 04:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:14 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 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:14 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 04:16:14 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 04:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:14 INFO - 'HOME': '/Users/cltbld', 04:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:14 INFO - 'LOGNAME': 'cltbld', 04:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:14 INFO - 'MOZ_NO_REMOTE': '1', 04:16:14 INFO - 'NO_EM_RESTART': '1', 04:16:14 INFO - 'PAGER': '/bin/cat', 04:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:14 INFO - 'PWD': '/builds/slave/test', 04:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:14 INFO - 'SHELL': '/bin/bash', 04:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:14 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:14 INFO - 'USER': 'cltbld', 04:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:14 INFO - 'XPC_FLAGS': '0x0', 04:16:14 INFO - 'XPC_SERVICE_NAME': '0', 04:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:14 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 04:16:14 INFO - Cleaning up... 04:16:14 INFO - Return code: 0 04:16:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:16:14 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')]} 04:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:14 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')]} 04:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:14 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 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:14 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 04:16:14 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 04:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:14 INFO - 'HOME': '/Users/cltbld', 04:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:14 INFO - 'LOGNAME': 'cltbld', 04:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:14 INFO - 'MOZ_NO_REMOTE': '1', 04:16:14 INFO - 'NO_EM_RESTART': '1', 04:16:14 INFO - 'PAGER': '/bin/cat', 04:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:14 INFO - 'PWD': '/builds/slave/test', 04:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:14 INFO - 'SHELL': '/bin/bash', 04:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:14 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:14 INFO - 'USER': 'cltbld', 04:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:14 INFO - 'XPC_FLAGS': '0x0', 04:16:14 INFO - 'XPC_SERVICE_NAME': '0', 04:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:14 INFO - Downloading/unpacking psutil>=0.7.1 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:16:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:17 INFO - Installing collected packages: psutil 04:16:17 INFO - Running setup.py install for psutil 04:16:17 INFO - building 'psutil._psutil_osx' extension 04:16:17 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 INFO - building 'psutil._psutil_posix' extension 04:16:18 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 04:16:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:16:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:16:18 INFO - ^ 04:16:18 INFO - 1 warning generated. 04:16:18 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 04:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:18 INFO - Successfully installed psutil 04:16:18 INFO - Cleaning up... 04:16:18 INFO - Return code: 0 04:16:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16:18 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')]} 04:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:18 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')]} 04:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:18 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 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:18 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 04:16:18 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 04:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:18 INFO - 'HOME': '/Users/cltbld', 04:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:18 INFO - 'LOGNAME': 'cltbld', 04:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:18 INFO - 'MOZ_NO_REMOTE': '1', 04:16:18 INFO - 'NO_EM_RESTART': '1', 04:16:18 INFO - 'PAGER': '/bin/cat', 04:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:18 INFO - 'PWD': '/builds/slave/test', 04:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:18 INFO - 'SHELL': '/bin/bash', 04:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:18 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:18 INFO - 'USER': 'cltbld', 04:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:18 INFO - 'XPC_FLAGS': '0x0', 04:16:18 INFO - 'XPC_SERVICE_NAME': '0', 04:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:16:21 INFO - Installing collected packages: mozsystemmonitor 04:16:21 INFO - Running setup.py install for mozsystemmonitor 04:16:21 INFO - Successfully installed mozsystemmonitor 04:16:21 INFO - Cleaning up... 04:16:21 INFO - Return code: 0 04:16:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:21 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 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:21 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 04:16:21 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 04:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:21 INFO - 'HOME': '/Users/cltbld', 04:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:21 INFO - 'LOGNAME': 'cltbld', 04:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:21 INFO - 'MOZ_NO_REMOTE': '1', 04:16:21 INFO - 'NO_EM_RESTART': '1', 04:16:21 INFO - 'PAGER': '/bin/cat', 04:16:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:21 INFO - 'PWD': '/builds/slave/test', 04:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:21 INFO - 'SHELL': '/bin/bash', 04:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:21 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:21 INFO - 'USER': 'cltbld', 04:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:21 INFO - 'XPC_FLAGS': '0x0', 04:16:21 INFO - 'XPC_SERVICE_NAME': '0', 04:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:25 INFO - Downloading docopt-0.6.1.tar.gz 04:16:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:25 INFO - Running setup.py install for blobuploader 04:16:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:26 INFO - Running setup.py install for requests 04:16:26 INFO - Running setup.py install for docopt 04:16:26 INFO - Successfully installed blobuploader requests docopt 04:16:26 INFO - Cleaning up... 04:16:26 INFO - Return code: 0 04:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:26 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')]} 04:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:26 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')]} 04:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:26 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 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:26 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 04:16:26 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 04:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:26 INFO - 'HOME': '/Users/cltbld', 04:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:26 INFO - 'LOGNAME': 'cltbld', 04:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:26 INFO - 'MOZ_NO_REMOTE': '1', 04:16:26 INFO - 'NO_EM_RESTART': '1', 04:16:26 INFO - 'PAGER': '/bin/cat', 04:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:26 INFO - 'PWD': '/builds/slave/test', 04:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:26 INFO - 'SHELL': '/bin/bash', 04:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:26 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:26 INFO - 'USER': 'cltbld', 04:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:26 INFO - 'XPC_FLAGS': '0x0', 04:16:26 INFO - 'XPC_SERVICE_NAME': '0', 04:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:27 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-g7vExg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:27 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Ktpbbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:27 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-AtX2UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:27 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-V4A0uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:27 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-s_M3f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:27 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-9xEV4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-mFDeBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-RkW3F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-B6GwNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Bjlp25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-2oCJh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-nhLB_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-pM96xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:28 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-afRhTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:29 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-BvH1jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:29 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-W5SMtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:29 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-voTcdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:29 INFO - Running setup.py install for manifestparser 04:16:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:29 INFO - Running setup.py install for mozcrash 04:16:29 INFO - Running setup.py install for mozdebug 04:16:29 INFO - Running setup.py install for mozdevice 04:16:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Running setup.py install for mozfile 04:16:30 INFO - Running setup.py install for mozhttpd 04:16:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Running setup.py install for mozinfo 04:16:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Running setup.py install for mozInstall 04:16:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:30 INFO - Running setup.py install for mozleak 04:16:30 INFO - Running setup.py install for mozlog 04:16:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:31 INFO - Running setup.py install for moznetwork 04:16:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:31 INFO - Running setup.py install for mozprocess 04:16:31 INFO - Running setup.py install for mozprofile 04:16:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:31 INFO - Running setup.py install for mozrunner 04:16:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Running setup.py install for mozscreenshot 04:16:32 INFO - Running setup.py install for moztest 04:16:32 INFO - Running setup.py install for mozversion 04:16:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:32 INFO - Cleaning up... 04:16:32 INFO - Return code: 0 04:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:32 INFO - 'HOME': '/Users/cltbld', 04:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:32 INFO - 'LOGNAME': 'cltbld', 04:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:32 INFO - 'MOZ_NO_REMOTE': '1', 04:16:32 INFO - 'NO_EM_RESTART': '1', 04:16:32 INFO - 'PAGER': '/bin/cat', 04:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:32 INFO - 'PWD': '/builds/slave/test', 04:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:32 INFO - 'SHELL': '/bin/bash', 04:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:32 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:32 INFO - 'USER': 'cltbld', 04:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:32 INFO - 'XPC_FLAGS': '0x0', 04:16:32 INFO - 'XPC_SERVICE_NAME': '0', 04:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:32 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-LBzkpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:33 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)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-9kj5UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:33 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)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-z7x3ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:33 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)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-TYRKmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:33 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)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-LjDJVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-YMy7Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-oOIKAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:33 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)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-O7G7Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:33 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Bt3A9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:34 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)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-0DkPgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:34 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)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-j8Vj0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-nBZ50_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-cosiSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-ErdruN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-BCRk77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:34 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-L0cFDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:35 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-buc7xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:35 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)) 04:16:35 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)) 04:16:35 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)) 04:16:35 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)) 04:16:35 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)) 04:16:35 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)) 04:16:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:35 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 04:16:35 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 04:16:35 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 04:16:35 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 04:16:35 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 04:16:35 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 04:16:37 INFO - Downloading blessings-1.5.1.tar.gz 04:16:37 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:37 INFO - Installing collected packages: blessings 04:16:37 INFO - Running setup.py install for blessings 04:16:37 INFO - Successfully installed blessings 04:16:37 INFO - Cleaning up... 04:16:38 INFO - Return code: 0 04:16:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:38 INFO - Reading from file tmpfile_stdout 04:16:38 INFO - Current package versions: 04:16:38 INFO - blessings == 1.5.1 04:16:38 INFO - blobuploader == 1.2.4 04:16:38 INFO - docopt == 0.6.1 04:16:38 INFO - manifestparser == 1.1 04:16:38 INFO - mozInstall == 1.12 04:16:38 INFO - mozcrash == 0.16 04:16:38 INFO - mozdebug == 0.1 04:16:38 INFO - mozdevice == 0.46 04:16:38 INFO - mozfile == 1.2 04:16:38 INFO - mozhttpd == 0.7 04:16:38 INFO - mozinfo == 0.8 04:16:38 INFO - mozleak == 0.1 04:16:38 INFO - mozlog == 3.0 04:16:38 INFO - moznetwork == 0.27 04:16:38 INFO - mozprocess == 0.22 04:16:38 INFO - mozprofile == 0.27 04:16:38 INFO - mozrunner == 6.11 04:16:38 INFO - mozscreenshot == 0.1 04:16:38 INFO - mozsystemmonitor == 0.0 04:16:38 INFO - moztest == 0.7 04:16:38 INFO - mozversion == 1.4 04:16:38 INFO - psutil == 3.1.1 04:16:38 INFO - requests == 1.2.3 04:16:38 INFO - wsgiref == 0.1.2 04:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ca746950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, '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.kJSV8qzDat/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.LWZMUtiD2A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 04:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:16:38 INFO - 'HOME': '/Users/cltbld', 04:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:16:38 INFO - 'LOGNAME': 'cltbld', 04:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:38 INFO - 'MOZ_NO_REMOTE': '1', 04:16:38 INFO - 'NO_EM_RESTART': '1', 04:16:38 INFO - 'PAGER': '/bin/cat', 04:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:38 INFO - 'PWD': '/builds/slave/test', 04:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:16:38 INFO - 'SHELL': '/bin/bash', 04:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:16:38 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:16:38 INFO - 'USER': 'cltbld', 04:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:38 INFO - 'XPC_FLAGS': '0x0', 04:16:38 INFO - 'XPC_SERVICE_NAME': '0', 04:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:38 INFO - Cleaning up... 04:16:38 INFO - Return code: 0 04:16:38 INFO - Running post-action listener: _resource_record_post_action 04:16:38 INFO - Running post-action listener: _start_resource_monitoring 04:16:38 INFO - Starting resource monitoring. 04:16:38 INFO - ##### 04:16:38 INFO - ##### Running install step. 04:16:38 INFO - ##### 04:16:38 INFO - Running pre-action listener: _resource_record_pre_action 04:16:38 INFO - Running main action method: install 04:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:39 INFO - Reading from file tmpfile_stdout 04:16:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:39 INFO - Reading from file tmpfile_stdout 04:16:39 INFO - Output received: 04:16:39 INFO - Usage: mozinstall [options] installer 04:16:39 INFO - Options: 04:16:39 INFO - -h, --help show this help message and exit 04:16:39 INFO - -d DEST, --destination=DEST 04:16:39 INFO - Directory to install application into. [default: 04:16:39 INFO - "/builds/slave/test"] 04:16:39 INFO - --app=APP Application being installed. [default: firefox] 04:16:39 INFO - mkdir: /builds/slave/test/build/application 04:16:39 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'] 04:16:39 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 04:17:18 INFO - Reading from file tmpfile_stdout 04:17:18 INFO - Output received: 04:17:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:17:18 INFO - Running post-action listener: _resource_record_post_action 04:17:18 INFO - ##### 04:17:18 INFO - ##### Running run-tests step. 04:17:18 INFO - ##### 04:17:18 INFO - Running pre-action listener: _resource_record_pre_action 04:17:18 INFO - Running main action method: run_tests 04:17:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:17:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:17:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:17:18 INFO - 2015-11-23 04:17:18.570 screenresolution[1957:9509] starting screenresolution argv=screenresolution get 04:17:18 INFO - 2015-11-23 04:17:18.574 screenresolution[1957:9509] Display 0: 1600x1200x32@60 04:17:18 INFO - 2015-11-23 04:17:18.581 screenresolution[1958:9511] starting screenresolution argv=screenresolution list 04:17:18 INFO - Available Modes on Display 0 04:17:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:17:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:17:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:17:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:17:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:17:18 INFO - Intel HD Graphics 3000: 04:17:18 INFO - Chipset Model: Intel HD Graphics 3000 04:17:18 INFO - Type: GPU 04:17:18 INFO - Bus: Built-In 04:17:18 INFO - VRAM (Total): 512 MB 04:17:18 INFO - VRAM (Dynamic, Max): 10 04:17:18 INFO - Vendor: Intel (0x8086) 04:17:18 INFO - Device ID: 0x0116 04:17:18 INFO - Revision ID: 0x0009 04:17:18 INFO - Displays: 04:17:18 INFO - Display: 04:17:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:17:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:17:18 INFO - Display Serial Number: 1600x1200 60 04:17:18 INFO - Main Display: Yes 04:17:18 INFO - Mirror: Off 04:17:18 INFO - Online: Yes 04:17:18 INFO - Rotation: Supported 04:17:18 INFO - Return code: 0 04:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:18 INFO - Python 2.7.3 04:17:18 INFO - Return code: 0 04:17:18 INFO - grabbing minidump binary from tooltool 04:17:18 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')]} 04:17:18 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 0x1010849f0>, '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 0x100de3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10104e990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:18 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 04:17:18 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 04:17:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:18 INFO - Return code: 0 04:17:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:17:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:17:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:18 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/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0031', '--webServer', 'localhost'] in /builds/slave/test/build 04:17:18 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/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0031 --webServer localhost 04:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kJSV8qzDat/Render', 04:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:18 INFO - 'HOME': '/Users/cltbld', 04:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:18 INFO - 'LOGNAME': 'cltbld', 04:17:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:18 INFO - 'MOZ_NO_REMOTE': '1', 04:17:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:18 INFO - 'NO_EM_RESTART': '1', 04:17:18 INFO - 'PAGER': '/bin/cat', 04:17:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:18 INFO - 'PWD': '/builds/slave/test', 04:17:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:18 INFO - 'SHELL': '/bin/bash', 04:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LWZMUtiD2A/Listeners', 04:17:18 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 04:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:18 INFO - 'USER': 'cltbld', 04:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:18 INFO - 'XPC_FLAGS': '0x0', 04:17:18 INFO - 'XPC_SERVICE_NAME': '0', 04:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:17:18 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/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0031', '--webServer', 'localhost'] with output_timeout 3600 04:17:19 INFO - mozversion INFO | application_buildid: 20151123032726 04:17:19 INFO - mozversion INFO | application_changeset: 79c9f80eeeb878601c2a9d01a805cda47dfede1f 04:17:19 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 04:17:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:19 INFO - mozversion INFO | application_name: Firefox 04:17:19 INFO - mozversion INFO | application_remotingname: firefox-dev 04:17:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:17:19 INFO - mozversion INFO | application_vendor: Mozilla 04:17:19 INFO - mozversion INFO | application_version: 44.0a2 04:17:19 INFO - mozversion INFO | platform_buildid: 20151123032726 04:17:19 INFO - mozversion INFO | platform_changeset: 79c9f80eeeb878601c2a9d01a805cda47dfede1f 04:17:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:17:19 INFO - mozversion INFO | platform_version: 44.0a2 04:17:19 INFO - 2015-11-23 04:17:19,230 DEBUG : using testdate: 1448281039 04:17:19 INFO - 2015-11-23 04:17:19,231 DEBUG : actual date: 1448281039 04:17:19 INFO - 2015-11-23 04:17:19,241 INFO : starting webserver on 'localhost:49462' 04:17:19 INFO - 2015-11-23 04:17:19,242 INFO : Starting test suite t-yosemite-r5-0031 04:17:19 INFO - 2015-11-23 04:17:19,242 INFO : Starting test dromaeo_css 04:17:19 INFO - 2015-11-23 04:17:19,242 DEBUG : operating with platform_type : mac_ 04:17:19 INFO - 2015-11-23 04:17:19,243 INFO : Initialising browser for dromaeo_css test... 04:17:19 INFO - 2015-11-23 04:17:19,266 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpby_97N/profile http://localhost:49462/getInfo.html 04:17:21 INFO - 2015-11-23 04:17:21,698 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:17:21 INFO - 2015-11-23 04:17:21,699 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:17:21 INFO - 2015-11-23 04:17:21,699 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:17:21 INFO - 2015-11-23 04:17:21,699 DEBUG : BROWSER_OUTPUT: __metrics 04:17:21 INFO - 2015-11-23 04:17:21,717 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:22 INFO - 2015-11-23 04:17:22,448 INFO : Browser initialized. 04:17:22 INFO - 2015-11-23 04:17:22,448 INFO : Running cycle 1/1 for dromaeo_css test... 04:17:22 INFO - 2015-11-23 04:17:22,449 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpby_97N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:17:34 INFO - 2015-11-23 04:17:34,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 198615040 04:17:34 INFO - 2015-11-23 04:17:34,448 DEBUG : BROWSER_OUTPUT: 04:18:25 INFO - 2015-11-23 04:18:25,874 DEBUG : BROWSER_OUTPUT: 1448281105870 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] 04:20:36 INFO - 2015-11-23 04:20:36,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49462/tests/dromaeo/cssquery-ext.html) 04:20:37 INFO - 2015-11-23 04:20:37,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 322449408 04:20:37 INFO - 2015-11-23 04:20:37,495 DEBUG : BROWSER_OUTPUT: 04:23:40 INFO - 2015-11-23 04:23:40,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-ext.html (next: http://localhost:49462/tests/dromaeo/cssquery-jquery.html) 04:23:40 INFO - 2015-11-23 04:23:40,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 342753280 04:23:40 INFO - 2015-11-23 04:23:40,883 DEBUG : BROWSER_OUTPUT: 04:26:43 INFO - 2015-11-23 04:26:43,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49462/tests/dromaeo/cssquery-mootools.html) 04:26:43 INFO - 2015-11-23 04:26:43,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 303075328 04:26:43 INFO - 2015-11-23 04:26:43,766 DEBUG : BROWSER_OUTPUT: 04:29:45 INFO - 2015-11-23 04:29:45,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49462/tests/dromaeo/cssquery-prototype.html) 04:29:46 INFO - 2015-11-23 04:29:46,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 298008576 04:29:46 INFO - 2015-11-23 04:29:46,412 DEBUG : BROWSER_OUTPUT: 04:32:49 INFO - 2015-11-23 04:32:49,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49462/tests/dromaeo/cssquery-yui.html) 04:32:50 INFO - 2015-11-23 04:32:50,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 299872256 04:32:50 INFO - 2015-11-23 04:32:50,065 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-yui.html (next: http://localhost:49462/tests/dromaeo/cssquery-dojo.html) 04:35:52 INFO - 2015-11-23 04:35:52,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 344612864 04:35:52 INFO - 2015-11-23 04:35:52,721 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,721 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:35:52 INFO - 2015-11-23 04:35:52,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:35:52 INFO - 2015-11-23 04:35:52,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:35:52 INFO - 2015-11-23 04:35:52,722 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:35:52 INFO - 2015-11-23 04:35:52,722 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2862.7280408361203;2937.280366310253;2940.8676609552563;2949.4838403279423;2974.0185738706214;4773.116973359926;4824.710517368961;4834.08152451034;4845.515448455153;4910.852674419764;4858.659893807426;4888.120138375091;4945.134601444751;4960.950390496094;4965.28003439501;4492.505824359318;4604.309353596954;4661.813527458898;4666.183417901871;4675.953240467586;4697.154512187805;4710.882227944295;4734.644901632374;4737.242041273397;4783.832565860195;4620.676552641316;4642.187617166982;4686.7656617169005;4697.553732395417;4722.763861806913;4565.611922986567;4650.116477869194;4671.11248862715;4704.200285951362;4739.312799644067;4639.002614437912;4674.672772905898;4719.9292010619865;4739.881502962419;4755.0489902019735;4677.74272415017;4776.5701086902345;4784.545468180518;4882.975585122087;4929.8028078876805;5134.5378915897745;5223.686578805284;5237.711925844077;5275.894482110375;5292.92060619091;5301.416844147179;5301.973490132525;5355.919661205085;5401.594880383947;5401.972990135064;4778.904421911542;4875.609951203895;4963.932754457809;4983.501649834988;5035.169197082477;5256.26412302278;5352.545033672103;5394.622376433612;5396.082665946798;5411.918821217685;5140.665856719302;5150.304708864255;5153.330067091254;5166.457521960216;5182.611304152204;4956.256561515802;5067.619928505377;5113.821016264487;5340;5359.812406565829;5099.6685215460875;5163.251328557338;5174.301469301671;5191.143461328914;5212.478752124833;5183.688978661293;5255.5532779713385;5299.549538289211;5303.681779093266;5341.65279256847;3989.900252493711;4118.155778065489;4126.628603425706;4140.254754144283;4170.103427763045;3585.1933315003917;3594.67647911684;3638.017735211478;3682;3746.026033231325;5019.0463811875625;5022.221555658879;5064.316317297192;5095.31213286209;5105.208692652571;4982.3522942018035;5078.873028174326;5145.871353216125;5390.299261096111;5396.163594642837;4887.193613053877;4943.604511639132;5016.398032236155;5023.723695196799;5063.240513922868;4576.8626941191815;4585.839495617637;4619.6073333766335;4622.86131416058;4645.396098507173;5168.198929165986;5271.077561426659;5327.893442131136;5373.4357892422295;5384;5219.556337711185;5309.389420216725;5338.3060202173465;5339.7063161526485;5340.198970154508;5365.7048862311385;5472.343318801769;5494;5497.780088796403;5505.614606977473;5114.667546609458;5204.843854684365;5258.553022992935;5293.47065293483;5362.758675859518;5335.866603334947;5426.240326354235;5451.018816613047;5451.209574611738;5462.890742185214;5243.213517972335;5249.501297376743;5304.734763261744;5318.441563635917;5325.387580428301;4981.10340138764;5081.4918508148885;5131;5197.66215196011;5286.286351342519;4878.243872199673;4962.131626965194;4983;4985.252212168204;4992.326035985096;5037.596992240538;5251.973740131275;5286.365636123536;5305.31030965972;5306.230596563554;4932.901341973212;5084.2627818966785;5087.592992560512;5161.277421160966;5174.7153906535505 04:35:52 INFO - 2015-11-23 04:35:52,722 DEBUG : BROWSER_OUTPUT: |1;ext.html;522.5871561466441;523.0663266070065;528.595624347374;534.2520471340122;550.865038065674;28937.565936510942;31243.531347029813;38049.80975095121;38113.809430952875;38532.22935541288;40460;40908.79545602275;41054.794726026405;41107.794461027726;41149.58850411495;7851.254130857559;8432.198941100602;8659.437136586133;8672.219500244977;8706.129387061275;7862.921370786305;10133.138683211935;10353.430561319163;10409.68770936873;10428.582856685724;10069.69790906274;10191.490425478734;10217.131543818747;10232.386056836576;10232.641857534987;8002.5998700064765;8200.876986845202;10165.288429809916;10222.131118854906;10241.641542546013;10039.89960100397;10106.696799096038;10123.89876101237;10141.2394070445;10158.441285729283;37172;37827;37948.62051379478;37989.43015854764;38079.809600952096;2637.0902038796585;2658.548046832024;2684.704682484925;2946.1603443018635;3102.9224269393444;25590;25883.611745823826;26311.21066368012;26412.339691507674;26729.33176670599;2125.415510734545;2220.3338998300446;2225.7329120505483;2250.9774902250933;2277.10054528462;266297;266790;267034;267649;268154.999999998;60579;61039.38960610426;61050.69474652598;61083.08375374373;61483.38516614777;60932.39067609356;63237.683811580646;70615.64692176506;72410;72542.2745772546;16100.75848862268;16118.032918024956;16327.183640817912;16481.76386770997;16492.350764923412;12456.688582785322;12548.749025019632;12556.686082847818;12556.748865022648;12665.36673166338;19387.127579258966;19545.902270488557;19737.802621973595;19744;19776.110075046658;7147.463940204401;7331.596762178025;7347.155077166088;7368.668409921566;7371.483996120327;839.345310657688;884.1644645809648;921.4563407589554;1004.8241557727368;1022.5194158745378;24635;25007.62488562673;25151.24546263615;25749.613755793678;26362.736372636027;874.1110629369994;958.6021800952666;1064.4837253931837;1072.6484629366898;1162.4478372773035;13204.60386188416;13797.10318829273;13964.650883727785;14596.416143354147;14823.481178158712;305273;310980;313719;313955;314900;44393.55606443959;45321.54678453173;51350;53882.7305863476;54204.45795542073;1314.6713321669583;1323.0209644862732;1323.7352529493946;1332.427056365772;1336.6391074409855;24697;25187.24438266855;25725.228243152735;25732.356691082874;26881.86559067192;43098;44510.77744611256;48450.5154948446;50101.49898500968;50226;243743;243809;247352;250151;250328;28598.57102143428;28642.85678571594;29149.85425072861;29287;29724.405511890072;39023.609763903136;40791.1841763169;40856.59143408647;41221.1755764877;42000.57999419967;32959.340813184084;34386;34618;34838.65161348455;35132.12169695778;33177.83411082929;33323.500147497325;33922.66077339195;33995.15012124618;34452;33757;34348.48477272893;34612.82693586516;34691;34694.65305347015;29783;30137.246568835955;30400.239994000327;30410.695893041673;30439.239019024702;22481.887590561942;22487.662685060066;22539.22259380197;22624.66063009089;22840.428989275402 04:35:52 INFO - 2015-11-23 04:35:52,722 DEBUG : BROWSER_OUTPUT: |2;jquery.html;320.9759268054895;321.7506432514802;326.79738562091507;330.17291684330746;330.7684620765465;13528.18830870146;13957.371918263678;15766.763498547516;16330.83669163308;17010.82989170108;13290.933545332284;13976.790348144787;15502.147381893992;16242.431514896982;16323.755143672824;4372.103718737659;5074.264231686403;5089;5104.464031276718;5106.668066575679;3703.703703703697;4950.430700469438;4999.475055119215;5002.77487513061;5011;4902.828401005965;5486.533644640211;5492.395836457987;5496.835094947158;5507.504324610784;5322.33470816148;5415.783368665248;5456.890862182754;5480.671159730429;5508.338999320067;4834.154023045953;4843.830465933711;4847.466778654345;4851.975740121312;4860.3195552622665;19639.410817675493;19940.60118797616;19975.600487990305;20284.391468255977;20397.38807835767;1863.2640107157733;1866.5371424039972;1881.9717704234447;2040.4694779357326;2056.5578400643785;12205.267683938904;12659.810102848465;12713.237205767684;12902.290374029424;13064.412101455457;1437.5112461762947;1531.111955066059;1531.3415231450472;1574.9527514174592;1575.3226112771504;57265.713671431375;57724;57972.71013644947;58505;58646.41353586495;9025.277977761763;9297.628094876265;9358.4384936904;9390.718278451657;9405.811883762286;11347.148963827582;11387.601433949938;11439.88560114405;11461.255018423775;11474.598389056342;7703.807404814925;7711.305982461606;7761.883571746315;7830.882536761953;7841.2158784122275;7957.7612671619945;8007.759767206877;8015.038195416588;8022.83954320922;8027.15714849944;5492.286002819687;5510.504054635022;5551.72241387929;5562.833115006556;5617.241672374177;1478.3569147420692;1568.0199875078076;1578.447543359838;1593.8645215156841;1597.3530720058395;802.3821657323828;862.8058686795546;905.7011186308503;920.995395023034;995.7460847483845;16674.166291685367;17037.14814259282;17405.738913916302;17444.563885902953;17484.038377889083;772.2817779465151;869.5912920927154;876.9517676527724;913.2921985461321;929.2008872369756;5077.416097148801;5196.45437229093;5206.505381988705;8838.204561589488;9429.90570094304;504319;508879.1004404811;519132;523569;573926;74465;74600.25399746042;75312;75485;75736.62131689416;387.81772566893517;389.68435567190664;389.7564022485946;389.8089935931373;390.49235993208714;8502.787430314043;8786.692465763668;9042.593083311136;9075.092490751136;9075.455472671661;34389;34601.30797383988;34895.65104349026;35073.29853402969;35491.64508354987;42741;46950;47002.059958799946;47966.28050579314;48038;7035.788926332013;7420.183779784112;7437.739679111205;7446.590437525988;7449.366803821519;10732.356058636507;10921.672349829518;10959.945200273947;11207.551697931991;11229.045531129945;9530.809383812424;9587.664431744855;9681.177099946583;9787.314887957775;9824.312298139062;9137.131972462605;9268.073192680678;9368.297377696565;9381.061893810564;9403.529823508934;7595.430342724208;9110.134537218953;9178.449293042439;9547.522623868917;9594.520273986132;6660.533762636569;7285.2714728528845;7441;7453.925460745323;7515.586642734702;9573.473458959825;9759.316847820868;9767.21862251004;9801.803963920824;9860 04:35:52 INFO - 2015-11-23 04:35:52,722 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1244.2347956007059;1538.3000734665727;1627.8930327377382;1637.5742307000185;1673.1801417305524;6574.934250657498;6815.931840681598;6851.520393572452;6921.204061532912;6953.687084081216;7108.999999999987;7153.928460715391;7162.247963963787;7165.534240274392;7204;1741.329588108581;1804.6210295837889;2015.2745011795778;2037.663785475395;2048.9180432782746;2019.4951262184454;2078.667413213886;2081.698153767703;2092.9790702092937;2093.434772611394;2004.7995200479982;2005.2580545198225;2028;2055.486128467883;2074.4502706782714;2003.2187446895723;2010.919563217477;2012.2755807909286;2035.9287424940205;2044.0903797810056;1979.7822239553639;1998.560316730317;2003.9098240579208;2015.083137172583;2017.3040301096098;7033.296670332977;7049.718011279542;7059.50583459158;7100.254473280334;7125.358717715379;4350.8912277193;4410.294352903552;4423.203823311803;4452.287633978548;4454.420925279693;2536.606825941982;2650.9204723858124;2652.840829550233;2656.53510635638;2668.906588269421;680.829792551862;728.1371574684016;737.6053811210976;738.785752131881;793.5080250244828;9443.15011648948;9459.905400945903;9501.762455938588;9515.857262141073;9531.428114313163;3907.1404291055924;4008.4788977432745;4033.092554175346;4062.3297155969526;4072.735272207297;8453.95773021131;8477.448965817326;8509.74470765878;8519.190676885686;8523.95738021306;4445.955540444555;4462.687611867138;4490.101979604092;4509.774511274423;4515;4071.4096456013713;4086.5504794472586;4099.631033206966;4114.444549985774;4114.670826333946;3423.845926933294;3450.016745227598;3497.4928635347733;3502.422100353413;3525.682688558042;1081.221520505235;1100.7908497385472;1103.1230172013268;1110.8111621024445;1115.642994241835;918.5499105438287;920.1580553793204;923.2337160157053;1126.695792136135;1165.81929800881;6542.542022058506;6548.3779040991985;6559.114519539801;6906.620135892575;7066.222715501291;1051.747580580655;1060.4909643371225;1066.2482949520725;1070.2347821307803;1080.9729756755987;5090;5096.311997880312;5110.872228194325;5111.821086262037;5159.355080614923;8032.39757018226;8455.112213217646;8458.87311690325;8591.44155629882;8600.053994060649;8147.348212143014;8301.709440169565;8433.873491897626;8450.154984501623;8485.109063548362;6630.071789949411;6679.332066793282;6693.297203793629;6739.292374300726;6748.055272261888;6502.60984340941;6656.068150459037;6702.631355275312;6725.529212955046;6743.022261772114;7517.1731109579;7571.545707257582;7585.2035536270105;7629.6566654499575;7647.120581133018;7622.885656715042;7759.379249660126;7815.687372505036;7830.177831327628;7859.4891332063235;6118.571699980958;6198.690065496798;6214.40963108504;6241.500679945502;6243.594166379171;6786.355296246848;6977;7023.894641580483;7038.8944165838575;7062.293770622897;6216.53375996793;6354.841128971812;6385.616862988236;6401.903971440339;6591.406773390418;6104.481119104926;6172.783952561639;6408.807735767934;6494.413062097396;6500.219973603198;5779.739911703899;6071.119687645355;6120.418560236771;6132.846678833065;6608.140941677551;5732.57005724564;5735.0537161369575;5740.827775166752;5794.391588883106;5795.652260864362;5427.294451721251;5892.263467066617;5895.086261629454;5917.970410147922;5921.14143449206 04:35:52 INFO - 2015-11-23 04:35:52,724 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.7453453693481;305.50965700051415;305.625608629429;308.27862801045546;309.6006152063838;5608.775648974036;5615.943840561604;5645.689487078209;5668.886622267552;5688.544916406688;5342.706151161694;5458.2904222451025;5467.425920278373;5533.031719449101;5603.215549823028;4381.605655491006;4386.056997745484;4388.67084968627;4390.209762242787;4426.62373698236;4191.077962848169;4384.736915785047;4401.625861801751;4430.02539441324;4434.933475997863;4221.071364299864;4273.551277115905;4349.369341445488;4351.3690514875325;4394;4333.588309110645;4338.110687309094;4355;4355.73865568067;4363.127374525107;3784.129650180474;3787.16682329887;3791.8104094795426;3794.4118661607495;3796.7152463565344;5377.6504527206;5392.4337944515655;5408.702521361323;5424.077906755861;5430.782768689248;4664.696794708333;4759.643026772971;4768.7854046567645;4776.020915712271;4782.928256076161;5802.7098645068;5806.274215723035;5824.563157763142;5828;5830.271216097988;3914.3737002079815;3925.391564307537;3938.1139243669945;3941.7437866538585;3952.01199700075;5957.553183511254;6027.60820546663;6102.6948652567635;6107.72515236811;6126.632402055891;3953.486046813896;3983.6215559521797;4013.6387725104296;4019.3569028955226;4026.214888096793;4073.2668119738137;4087.816048277835;4111.650509706708;4113.136241389342;4116.526599441043;4746.905061898812;4751.239801631791;4751.477337492873;4756.191447453941;4765.833195838129;5770.798022069207;5773.134029895549;5810.389909059572;5828.125781132864;5843.707814609253;1450.4560789703862;1470.852914708542;1475.837657857635;1484.5694748522808;1485.123776971592;940.9670661526814;941.270515350595;959.596969272907;960.5677445149711;962.225408546113;5619.241402410704;5630.577706672016;5657.43425657431;5671.234383358194;5699.572532060112;6113.786017489367;6120.44915957566;6122.081687746784;6122.357152499013;6151.077338399186;5482.890342193134;5548.500634942875;5565.860853478695;5639.069553523623;5647.011772939802;3335.0161702297883;3349.815760133216;3355.966440335614;3356.9328613427597;3369.157710572357;6101.267847858197;6105;6110.847228819226;6119.571629985947;6123.020316749388;6023.367546407564;6169.660668663267;6184.319724830265;6207.162033125561;6230.626162430269;6175.073738939195;6202.162708034358;6207.5654704171175;6219.440250377488;6236.563440559117;6148.723307451265;6172.598781079216;6193;6204.534659900435;6234.220722409699;5904.3210030847;5998.520118390431;6064.302605200459;6075.027995520695;6083.513318934563;6220.564560480723;6226.937730622817;6231.781887633911;6240.313565507699;6244.188255526752;3921.8039098044414;3929.174873276644;3944.6055394460323;3959.980200098981;3960.4851369322955;6157.138000679819;6167.229096362955;6186.1339412483185;6188.350223226496;6209.751609935552;5882.852928676817;5958.702064896651;5959.374265702038;5967.104934259895;5993.790217342372;5937;5949.137375080502;5953.851153721192;5958.940410596012;5964.015937370459;5723.570732195185;5738.311402631711;5755.251817263729;5767.798127065533;5785.190073389645;5780.450857168562;5967.104934259895;6019.247594050744;6020.277566692025;6034.155218269358;5824.097264923944;5844.4155584442915;5886.23478947734;5886.646801191942;5892.027815410409 04:35:52 INFO - 2015-11-23 04:35:52,725 DEBUG : BROWSER_OUTPUT: |5;yui.html;579.8608333999839;668.9866202675946;676.8037269191934;680.9285025072368;686.99012451696;12089.576864809722;12392.566260180884;12405.813912791315;12438.44027018784;12443.315617641027;12949.80575291369;13280.667983300422;13397.062205645609;13408.463661453554;13459.663508412295;670.540679634452;672.2235817630644;815.3966065111804;818.378032695153;830.8836762853175;818.8239528501371;823.0288259853371;823.0575990490885;827.2843989948681;828.5484410995991;836.1721895323616;839.102160688064;843.6456688190974;845.7589586967715;851.2381418630322;687.9896801547981;690.0270618427993;838.119974027275;846.4794151596785;849.5412477262271;616.165096294519;617.9598326108834;622.1445512420422;623.3392603839899;625.1810128731377;12723.23660580359;12739.426725797268;12764.425600847891;12865.035122365767;12872.678183045406;8641.135886411372;8670.08964058771;8852.336074794352;9353.485558294291;9376.343655944087;7926.445148839583;8103.878441823377;8244.464109832901;8289.41974061816;8365.790855228606;2643.6959749628845;2672.7995400345053;2694.6362241097595;2729.0175536806732;2816.4226333601564;43630.78184609057;43828.56171438277;44180.11639767187;44200;44293.55706442959;5730.828075157752;5820.621659592113;5948.494377977834;6094.939050609437;6162.921488739453;10301.381917084998;10333.586656533806;10341.431221282752;10356.378617282988;10380.06579407857;5110.28456016158;5151.0470562945975;5161.045206636709;5293.920591191135;5422.8373148805595;3433.364827506919;3440.088376580158;3457.1702791330404;3468.115630514253;3600.855965761393;2291.4042348989383;2313.2944451941985;2316.8262380321544;2320.6751054852334;2321.814254859607;357.14285714285404;364.02622983519507;371.03345784232226;375.44809130578005;376.12738446803155;399.86204759357975;400.62275021568456;450.1919055295752;514.6011840823317;534.3907944942769;6625.834354141089;6655;6790.151007959494;6944.791656250321;7066.893996590055;385.6336480343685;390.39878586976306;431.77763451822335;477.4867017955642;481.301200275881;2914.198595386286;3055.205646531918;3128.202308411386;3150.700683435116;3150.7164355207683;56791.432085678614;57104.42895571074;57468;57606.71196644074;57784.4221557779;49028.509714903106;49053.018939621725;49209;49315.26027109596;49653.751731241835;42695.57304426978;43113.784431078275;43778;43836;43989.90025249458;6275.058741188675;6360.77737279193;6436.324185960594;6514.348565143448;7466.216047315171;32011.679883200868;32306.35387292288;32796.508052378755;32950;33022.83488582542;42200.36699449449;42706.57293427026;43259.783701081295;43707.56292437035;43982.78008609937;6282.057691346335;6329.30377658448;6435.485161187187;6540.803775886731;6704.296048914794;9832.213422926006;9891.2581556385;10175.592976280866;10449.05958463742;10487.37075775456;9532.809343812945;9655.951720241354;9717.514124293615;9759.219262459128;9776.511174441392;9744.658936937172;9745.707628771148;9825.705228843146;9834.065763752433;9854.507274636382;9400.858987115336;9441.386309889835;9576.186024188022;9664.661736839176;9672.177864881563;8097.352211822922;8246.876296855431;8290.87563686533;8487;8663.220310172115;7750.7674769756995;7776.416768742254;7924.247196516321;8117.675292988214;8196.42625016243 04:35:52 INFO - 2015-11-23 04:35:52,726 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:35:52 INFO - 2015-11-23 04:35:52,726 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:35:52 INFO - 2015-11-23 04:35:52,726 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 04:35:52 INFO - 2015-11-23 04:35:52,726 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:35:52 INFO - 2015-11-23 04:35:52,726 DEBUG : BROWSER_OUTPUT: __startTimestamp1448282152712__endTimestamp 04:35:52 INFO - 2015-11-23 04:35:52,726 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,727 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:35:52 INFO - 2015-11-23 04:35:52,727 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:35:52 INFO - 2015-11-23 04:35:52,727 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,727 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4928.12 Median:5064.32 stddev:522.60 (10.3%) stddev-sans-first:498.45 04:35:52 INFO - 2015-11-23 04:35:52,728 DEBUG : BROWSER_OUTPUT: Values: 2862.7 2937.3 2940.9 2949.5 2974.0 4773.1 4824.7 4834.1 4845.5 4910.9 4858.7 4888.1 4945.1 4961.0 4965.3 4492.5 4604.3 4661.8 4666.2 4676.0 4697.2 4710.9 4734.6 4737.2 4783.8 4620.7 4642.2 4686.8 4697.6 4722.8 4565.6 4650.1 4671.1 4704.2 4739.3 4639.0 4674.7 4719.9 4739.9 4755.0 4677.7 4776.6 4784.5 4883.0 4929.8 5134.5 5223.7 5237.7 5275.9 5292.9 5301.4 5302.0 5355.9 5401.6 5402.0 4778.9 4875.6 4963.9 4983.5 5035.2 5256.3 5352.5 5394.6 5396.1 5411.9 5140.7 5150.3 5153.3 5166.5 5182.6 4956.3 5067.6 5113.8 5340.0 5359.8 5099.7 5163.3 5174.3 5191.1 5212.5 5183.7 5255.6 5299.5 5303.7 5341.7 3989.9 4118.2 4126.6 4140.3 4170.1 3585.2 3594.7 3638.0 3682.0 3746.0 5019.0 5022.2 5064.3 5095.3 5105.2 4982.4 5078.9 5145.9 5390.3 5396.2 4887.2 4943.6 5016.4 5023.7 5063.2 4576.9 4585.8 4619.6 4622.9 4645.4 5168.2 5271.1 5327.9 5373.4 5384.0 5219.6 5309.4 5338.3 5339.7 5340.2 5365.7 5472.3 5494.0 5497.8 5505.6 5114.7 5204.8 5258.6 5293.5 5362.8 5335.9 5426.2 5451.0 5451.2 5462.9 5243.2 5249.5 5304.7 5318.4 5325.4 4981.1 5081.5 5131.0 5197.7 5286.3 4878.2 4962.1 4983.0 4985.3 4992.3 5037.6 5252.0 5286.4 5305.3 5306.2 4932.9 5084.3 5087.6 5161.3 5174.7 04:35:52 INFO - 2015-11-23 04:35:52,728 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,728 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44306.41 Median:16335.28 stddev:72353.57 (442.9%) stddev-sans-first:72481.85 04:35:52 INFO - 2015-11-23 04:35:52,730 DEBUG : BROWSER_OUTPUT: Values: 522.6 523.1 528.6 534.3 550.9 28937.6 31243.5 38049.8 38113.8 38532.2 40460.0 40908.8 41054.8 41107.8 41149.6 7851.3 8432.2 8659.4 8672.2 8706.1 7862.9 10133.1 10353.4 10409.7 10428.6 10069.7 10191.5 10217.1 10232.4 10232.6 8002.6 8200.9 10165.3 10222.1 10241.6 10039.9 10106.7 10123.9 10141.2 10158.4 37172.0 37827.0 37948.6 37989.4 38079.8 2637.1 2658.5 2684.7 2946.2 3102.9 25590.0 25883.6 26311.2 26412.3 26729.3 2125.4 2220.3 2225.7 2251.0 2277.1 266297.0 266790.0 267034.0 267649.0 268155.0 60579.0 61039.4 61050.7 61083.1 61483.4 60932.4 63237.7 70615.6 72410.0 72542.3 16100.8 16118.0 16327.2 16481.8 16492.4 12456.7 12548.7 12556.7 12556.7 12665.4 19387.1 19545.9 19737.8 19744.0 19776.1 7147.5 7331.6 7347.2 7368.7 7371.5 839.3 884.2 921.5 1004.8 1022.5 24635.0 25007.6 25151.2 25749.6 26362.7 874.1 958.6 1064.5 1072.6 1162.4 13204.6 13797.1 13964.7 14596.4 14823.5 305273.0 310980.0 313719.0 313955.0 314900.0 44393.6 45321.5 51350.0 53882.7 54204.5 1314.7 1323.0 1323.7 1332.4 1336.6 24697.0 25187.2 25725.2 25732.4 26881.9 43098.0 44510.8 48450.5 50101.5 50226.0 243743.0 243809.0 247352.0 250151.0 250328.0 28598.6 28642.9 29149.9 29287.0 29724.4 39023.6 40791.2 40856.6 41221.2 42000.6 32959.3 34386.0 34618.0 34838.7 35132.1 33177.8 33323.5 33922.7 33995.2 34452.0 33757.0 34348.5 34612.8 34691.0 34694.7 29783.0 30137.2 30400.2 30410.7 30439.2 22481.9 22487.7 22539.2 22624.7 22840.4 04:35:52 INFO - 2015-11-23 04:35:52,730 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,730 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27078.64 Median:5201.48 stddev:86168.10 (1656.6%) stddev-sans-first:86386.40 04:35:52 INFO - 2015-11-23 04:35:52,731 DEBUG : BROWSER_OUTPUT: Values: 321.0 321.8 326.8 330.2 330.8 13528.2 13957.4 15766.8 16330.8 17010.8 13290.9 13976.8 15502.1 16242.4 16323.8 4372.1 5074.3 5089.0 5104.5 5106.7 3703.7 4950.4 4999.5 5002.8 5011.0 4902.8 5486.5 5492.4 5496.8 5507.5 5322.3 5415.8 5456.9 5480.7 5508.3 4834.2 4843.8 4847.5 4852.0 4860.3 19639.4 19940.6 19975.6 20284.4 20397.4 1863.3 1866.5 1882.0 2040.5 2056.6 12205.3 12659.8 12713.2 12902.3 13064.4 1437.5 1531.1 1531.3 1575.0 1575.3 57265.7 57724.0 57972.7 58505.0 58646.4 9025.3 9297.6 9358.4 9390.7 9405.8 11347.1 11387.6 11439.9 11461.3 11474.6 7703.8 7711.3 7761.9 7830.9 7841.2 7957.8 8007.8 8015.0 8022.8 8027.2 5492.3 5510.5 5551.7 5562.8 5617.2 1478.4 1568.0 1578.4 1593.9 1597.4 802.4 862.8 905.7 921.0 995.7 16674.2 17037.1 17405.7 17444.6 17484.0 772.3 869.6 877.0 913.3 929.2 5077.4 5196.5 5206.5 8838.2 9429.9 504319.0 508879.1 519132.0 523569.0 573926.0 74465.0 74600.3 75312.0 75485.0 75736.6 387.8 389.7 389.8 389.8 390.5 8502.8 8786.7 9042.6 9075.1 9075.5 34389.0 34601.3 34895.7 35073.3 35491.6 42741.0 46950.0 47002.1 47966.3 48038.0 7035.8 7420.2 7437.7 7446.6 7449.4 10732.4 10921.7 10959.9 11207.6 11229.0 9530.8 9587.7 9681.2 9787.3 9824.3 9137.1 9268.1 9368.3 9381.1 9403.5 7595.4 9110.1 9178.4 9547.5 9594.5 6660.5 7285.3 7441.0 7453.9 7515.6 9573.5 9759.3 9767.2 9801.8 9860.0 04:35:52 INFO - 2015-11-23 04:35:52,732 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,732 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4963.18 Median:6119.50 stddev:2558.85 (41.8%) stddev-sans-first:2550.76 04:35:52 INFO - 2015-11-23 04:35:52,732 DEBUG : BROWSER_OUTPUT: Values: 1244.2 1538.3 1627.9 1637.6 1673.2 6574.9 6815.9 6851.5 6921.2 6953.7 7109.0 7153.9 7162.2 7165.5 7204.0 1741.3 1804.6 2015.3 2037.7 2048.9 2019.5 2078.7 2081.7 2093.0 2093.4 2004.8 2005.3 2028.0 2055.5 2074.5 2003.2 2010.9 2012.3 2035.9 2044.1 1979.8 1998.6 2003.9 2015.1 2017.3 7033.3 7049.7 7059.5 7100.3 7125.4 4350.9 4410.3 4423.2 4452.3 4454.4 2536.6 2650.9 2652.8 2656.5 2668.9 680.8 728.1 737.6 738.8 793.5 9443.2 9459.9 9501.8 9515.9 9531.4 3907.1 4008.5 4033.1 4062.3 4072.7 8454.0 8477.4 8509.7 8519.2 8524.0 4446.0 4462.7 4490.1 4509.8 4515.0 4071.4 4086.6 4099.6 4114.4 4114.7 3423.8 3450.0 3497.5 3502.4 3525.7 1081.2 1100.8 1103.1 1110.8 1115.6 918.5 920.2 923.2 1126.7 1165.8 6542.5 6548.4 6559.1 6906.6 7066.2 1051.7 1060.5 1066.2 1070.2 1081.0 5090.0 5096.3 5110.9 5111.8 5159.4 8032.4 8455.1 8458.9 8591.4 8600.1 8147.3 8301.7 8433.9 8450.2 8485.1 6630.1 6679.3 6693.3 6739.3 6748.1 6502.6 6656.1 6702.6 6725.5 6743.0 7517.2 7571.5 7585.2 7629.7 7647.1 7622.9 7759.4 7815.7 7830.2 7859.5 6118.6 6198.7 6214.4 6241.5 6243.6 6786.4 6977.0 7023.9 7038.9 7062.3 6216.5 6354.8 6385.6 6401.9 6591.4 6104.5 6172.8 6408.8 6494.4 6500.2 5779.7 6071.1 6120.4 6132.8 6608.1 5732.6 5735.1 5740.8 5794.4 5795.7 5427.3 5892.3 5895.1 5918.0 5921.1 04:35:52 INFO - 2015-11-23 04:35:52,732 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,732 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4915.80 Median:5663.16 stddev:1490.03 (26.3%) stddev-sans-first:1453.15 04:35:52 INFO - 2015-11-23 04:35:52,734 DEBUG : BROWSER_OUTPUT: Values: 287.7 305.5 305.6 308.3 309.6 5608.8 5615.9 5645.7 5668.9 5688.5 5342.7 5458.3 5467.4 5533.0 5603.2 4381.6 4386.1 4388.7 4390.2 4426.6 4191.1 4384.7 4401.6 4430.0 4434.9 4221.1 4273.6 4349.4 4351.4 4394.0 4333.6 4338.1 4355.0 4355.7 4363.1 3784.1 3787.2 3791.8 3794.4 3796.7 5377.7 5392.4 5408.7 5424.1 5430.8 4664.7 4759.6 4768.8 4776.0 4782.9 5802.7 5806.3 5824.6 5828.0 5830.3 3914.4 3925.4 3938.1 3941.7 3952.0 5957.6 6027.6 6102.7 6107.7 6126.6 3953.5 3983.6 4013.6 4019.4 4026.2 4073.3 4087.8 4111.7 4113.1 4116.5 4746.9 4751.2 4751.5 4756.2 4765.8 5770.8 5773.1 5810.4 5828.1 5843.7 1450.5 1470.9 1475.8 1484.6 1485.1 941.0 941.3 959.6 960.6 962.2 5619.2 5630.6 5657.4 5671.2 5699.6 6113.8 6120.4 6122.1 6122.4 6151.1 5482.9 5548.5 5565.9 5639.1 5647.0 3335.0 3349.8 3356.0 3356.9 3369.2 6101.3 6105.0 6110.8 6119.6 6123.0 6023.4 6169.7 6184.3 6207.2 6230.6 6175.1 6202.2 6207.6 6219.4 6236.6 6148.7 6172.6 6193.0 6204.5 6234.2 5904.3 5998.5 6064.3 6075.0 6083.5 6220.6 6226.9 6231.8 6240.3 6244.2 3921.8 3929.2 3944.6 3960.0 3960.5 6157.1 6167.2 6186.1 6188.4 6209.8 5882.9 5958.7 5959.4 5967.1 5993.8 5937.0 5949.1 5953.9 5958.9 5964.0 5723.6 5738.3 5755.3 5767.8 5785.2 5780.5 5967.1 6019.2 6020.3 6034.2 5824.1 5844.4 5886.2 5886.6 5892.0 04:35:52 INFO - 2015-11-23 04:35:52,734 DEBUG : BROWSER_OUTPUT: 04:35:52 INFO - 2015-11-23 04:35:52,734 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12215.93 Median:31599.41 stddev:15498.55 (49.0%) stddev-sans-first:15517.39 04:35:52 INFO - 2015-11-23 04:35:52,735 DEBUG : BROWSER_OUTPUT: Values: 579.9 669.0 676.8 680.9 687.0 12089.6 12392.6 12405.8 12438.4 12443.3 12949.8 13280.7 13397.1 13408.5 13459.7 670.5 672.2 815.4 818.4 830.9 818.8 823.0 823.1 827.3 828.5 836.2 839.1 843.6 845.8 851.2 688.0 690.0 838.1 846.5 849.5 616.2 618.0 622.1 623.3 625.2 12723.2 12739.4 12764.4 12865.0 12872.7 8641.1 8670.1 8852.3 9353.5 9376.3 7926.4 8103.9 8244.5 8289.4 8365.8 2643.7 2672.8 2694.6 2729.0 2816.4 43630.8 43828.6 44180.1 44200.0 44293.6 5730.8 5820.6 5948.5 6094.9 6162.9 10301.4 10333.6 10341.4 10356.4 10380.1 5110.3 5151.0 5161.0 5293.9 5422.8 3433.4 3440.1 3457.2 3468.1 3600.9 2291.4 2313.3 2316.8 2320.7 2321.8 357.1 364.0 371.0 375.4 376.1 399.9 400.6 450.2 514.6 534.4 6625.8 6655.0 6790.2 6944.8 7066.9 385.6 390.4 431.8 477.5 481.3 2914.2 3055.2 3128.2 3150.7 3150.7 56791.4 57104.4 57468.0 57606.7 57784.4 49028.5 49053.0 49209.0 49315.3 49653.8 42695.6 43113.8 43778.0 43836.0 43989.9 6275.1 6360.8 6436.3 6514.3 7466.2 32011.7 32306.4 32796.5 32950.0 33022.8 42200.4 42706.6 43259.8 43707.6 43982.8 6282.1 6329.3 6435.5 6540.8 6704.3 9832.2 9891.3 10175.6 10449.1 10487.4 9532.8 9656.0 9717.5 9759.2 9776.5 9744.7 9745.7 9825.7 9834.1 9854.5 9400.9 9441.4 9576.2 9664.7 9672.2 8097.4 8246.9 8290.9 8487.0 8663.2 7750.8 7776.4 7924.2 8117.7 8196.4 04:35:52 INFO - 2015-11-23 04:35:52,735 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:35:52 INFO - 2015-11-23 04:35:52,735 DEBUG : BROWSER_OUTPUT: 04:35:53 INFO - 2015-11-23 04:35:53,416 INFO : Browser exited with error code: 0 04:35:53 INFO - 2015-11-23 04:35:53,447 INFO : Completed test dromaeo_css (00:18:34) 04:35:53 INFO - 2015-11-23 04:35:53,447 INFO : Starting test kraken 04:35:53 INFO - 2015-11-23 04:35:53,448 DEBUG : operating with platform_type : mac_ 04:35:53 INFO - 2015-11-23 04:35:53,448 INFO : Initialising browser for kraken test... 04:35:53 INFO - 2015-11-23 04:35:53,462 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmptinGzs/profile http://localhost:49462/getInfo.html 04:35:55 INFO - 2015-11-23 04:35:55,820 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:35:55 INFO - 2015-11-23 04:35:55,820 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:35:55 INFO - 2015-11-23 04:35:55,820 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:35:55 INFO - 2015-11-23 04:35:55,820 DEBUG : BROWSER_OUTPUT: __metrics 04:35:55 INFO - 2015-11-23 04:35:55,835 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:56 INFO - 2015-11-23 04:35:56,544 INFO : Browser initialized. 04:35:56 INFO - 2015-11-23 04:35:56,544 INFO : Running cycle 1/1 for kraken test... 04:35:56 INFO - 2015-11-23 04:35:56,544 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmptinGzs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:36:08 INFO - 2015-11-23 04:36:08,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 198758400 04:36:08 INFO - 2015-11-23 04:36:08,528 DEBUG : BROWSER_OUTPUT: 04:36:11 INFO - 2015-11-23 04:36:11,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:11 INFO - 2015-11-23 04:36:11,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 265691136 04:36:11 INFO - 2015-11-23 04:36:11,853 DEBUG : BROWSER_OUTPUT: 04:36:14 INFO - 2015-11-23 04:36:14,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-dft) 04:36:15 INFO - 2015-11-23 04:36:15,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 281014272 04:36:15 INFO - 2015-11-23 04:36:15,386 DEBUG : BROWSER_OUTPUT: 04:36:18 INFO - 2015-11-23 04:36:18,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-fft) 04:36:19 INFO - 2015-11-23 04:36:19,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 270278656 04:36:19 INFO - 2015-11-23 04:36:19,042 DEBUG : BROWSER_OUTPUT: 04:36:21 INFO - 2015-11-23 04:36:21,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator) 04:36:21 INFO - 2015-11-23 04:36:21,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 269664256 04:36:21 INFO - 2015-11-23 04:36:21,827 DEBUG : BROWSER_OUTPUT: 04:36:24 INFO - 2015-11-23 04:36:24,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:24 INFO - 2015-11-23 04:36:24,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 270430208 04:36:24 INFO - 2015-11-23 04:36:24,776 DEBUG : BROWSER_OUTPUT: 04:36:28 INFO - 2015-11-23 04:36:28,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:28 INFO - 2015-11-23 04:36:28,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 271282176 04:36:28 INFO - 2015-11-23 04:36:28,689 DEBUG : BROWSER_OUTPUT: 04:36:32 INFO - 2015-11-23 04:36:32,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:32 INFO - 2015-11-23 04:36:32,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 271994880 04:36:32 INFO - 2015-11-23 04:36:32,665 DEBUG : BROWSER_OUTPUT: 04:36:35 INFO - 2015-11-23 04:36:35,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial) 04:36:36 INFO - 2015-11-23 04:36:36,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 271171584 04:36:36 INFO - 2015-11-23 04:36:36,395 DEBUG : BROWSER_OUTPUT: 04:36:38 INFO - 2015-11-23 04:36:38,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:38 INFO - 2015-11-23 04:36:38,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 302534656 04:36:38 INFO - 2015-11-23 04:36:38,686 DEBUG : BROWSER_OUTPUT: 04:36:40 INFO - 2015-11-23 04:36:40,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:41 INFO - 2015-11-23 04:36:41,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 303292416 04:36:41 INFO - 2015-11-23 04:36:41,258 DEBUG : BROWSER_OUTPUT: 04:36:43 INFO - 2015-11-23 04:36:43,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:44 INFO - 2015-11-23 04:36:44,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 309035008 04:36:44 INFO - 2015-11-23 04:36:44,063 DEBUG : BROWSER_OUTPUT: 04:36:46 INFO - 2015-11-23 04:36:46,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:47 INFO - 2015-11-23 04:36:47,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 311427072 04:36:47 INFO - 2015-11-23 04:36:47,443 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-11-23 04:36:50,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:50 INFO - 2015-11-23 04:36:50,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 310689792 04:36:50 INFO - 2015-11-23 04:36:50,816 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49462/tests/kraken/driver.html?testName=ai-astar) 04:36:52 INFO - 2015-11-23 04:36:52,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 370630656 04:36:52 INFO - 2015-11-23 04:36:52,914 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,915 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:36:52 INFO - 2015-11-23 04:36:52,915 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:36:52 INFO - 2015-11-23 04:36:52,915 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:36:52 INFO - 2015-11-23 04:36:52,915 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:36:52 INFO - 2015-11-23 04:36:52,916 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;113;113;120;123;124;132;123;120;120 04:36:52 INFO - 2015-11-23 04:36:52,916 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;173;149;216;207;145;163;140;180;171;144 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;179;180;182;182;181;180;180;181;188 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |3;audio-fft;89;89;86;136;77;80;81;78;135;73 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;113;154;103;104;101;144;99;99;146 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;131;142;130;135;129;135;135;137;135 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;140;140;146;140;140;140;140;140;140;140 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;118;113;113;119;114;112;114;118;116 04:36:52 INFO - 2015-11-23 04:36:52,917 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;70;71;72;70;72;73;80;64;65 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;73;74;75;78;79;76;76;75;76 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;92;97;96;94;94;92;93;93;103 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;145;142;141;129;143;140;148;151;135;139 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;165;166;152;156;166;152;164;164;170;169 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;75;77;79;78;77;77;80;81;81 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:36:52 INFO - 2015-11-23 04:36:52,918 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,907 04:36:52 INFO - 2015-11-23 04:36:52,919 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:36:52 INFO - 2015-11-23 04:36:52,919 DEBUG : BROWSER_OUTPUT: __startTimestamp1448282212914__endTimestamp 04:36:52 INFO - 2015-11-23 04:36:52,919 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,920 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:36:52 INFO - 2015-11-23 04:36:52,920 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:36:52 INFO - 2015-11-23 04:36:52,920 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.30 Median:121.50 stddev:5.77 (4.8%) stddev-sans-first:5.80 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: Values: 115.0 113.0 113.0 120.0 123.0 124.0 132.0 123.0 120.0 120.0 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:168.80 Median:172.00 stddev:26.40 (15.3%) stddev-sans-first:27.96 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: Values: 173.0 149.0 216.0 207.0 145.0 163.0 140.0 180.0 171.0 144.0 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.30 Median:181.00 stddev:2.54 (1.4%) stddev-sans-first:2.65 04:36:52 INFO - 2015-11-23 04:36:52,921 DEBUG : BROWSER_OUTPUT: Values: 180.0 179.0 180.0 182.0 182.0 181.0 180.0 180.0 181.0 188.0 04:36:52 INFO - 2015-11-23 04:36:52,922 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,922 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.40 Median:80.50 stddev:23.30 (28.9%) stddev-sans-first:24.68 04:36:52 INFO - 2015-11-23 04:36:52,922 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 86.0 136.0 77.0 80.0 81.0 78.0 135.0 73.0 04:36:52 INFO - 2015-11-23 04:36:52,922 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,922 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.30 Median:145.00 stddev:21.79 (15.0%) stddev-sans-first:22.95 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 154.0 103.0 104.0 101.0 144.0 99.0 99.0 146.0 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.50 Median:135.00 stddev:3.78 (2.8%) stddev-sans-first:3.97 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: Values: 136.0 131.0 142.0 130.0 135.0 129.0 135.0 135.0 137.0 135.0 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:140.60 Median:140.00 stddev:1.90 (1.4%) stddev-sans-first:2.00 04:36:52 INFO - 2015-11-23 04:36:52,923 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 146.0 140.0 140.0 140.0 140.0 140.0 140.0 140.0 04:36:52 INFO - 2015-11-23 04:36:52,924 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,924 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:115.20 Median:115.50 stddev:2.44 (2.1%) stddev-sans-first:2.59 04:36:52 INFO - 2015-11-23 04:36:52,925 DEBUG : BROWSER_OUTPUT: Values: 115.0 118.0 113.0 113.0 119.0 114.0 112.0 114.0 118.0 116.0 04:36:52 INFO - 2015-11-23 04:36:52,925 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,925 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.60 Median:71.50 stddev:5.76 (8.1%) stddev-sans-first:4.66 04:36:52 INFO - 2015-11-23 04:36:52,925 DEBUG : BROWSER_OUTPUT: Values: 59.0 70.0 71.0 72.0 70.0 72.0 73.0 80.0 64.0 65.0 04:36:52 INFO - 2015-11-23 04:36:52,925 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:76.00 stddev:2.53 (3.3%) stddev-sans-first:1.86 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 74.0 75.0 78.0 79.0 76.0 76.0 75.0 76.0 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:93.50 stddev:3.50 (3.7%) stddev-sans-first:3.48 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 97.0 96.0 94.0 94.0 92.0 93.0 93.0 103.0 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,926 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:142.50 stddev:6.27 (4.4%) stddev-sans-first:6.51 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: Values: 145.0 142.0 141.0 129.0 143.0 140.0 148.0 151.0 135.0 139.0 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:165.50 stddev:6.64 (4.0%) stddev-sans-first:6.97 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: Values: 165.0 166.0 152.0 156.0 166.0 152.0 164.0 164.0 170.0 169.0 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:78.50 stddev:2.57 (3.3%) stddev-sans-first:2.06 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 77.0 79.0 78.0 77.0 77.0 80.0 81.0 81.0 04:36:52 INFO - 2015-11-23 04:36:52,927 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:36:52 INFO - 2015-11-23 04:36:52,928 DEBUG : BROWSER_OUTPUT: 04:36:53 INFO - 2015-11-23 04:36:53,619 INFO : Browser exited with error code: 0 04:36:53 INFO - 2015-11-23 04:36:53,671 INFO : Completed test kraken (00:01:00) 04:36:53 INFO - 2015-11-23 04:36:53,671 INFO : Starting test v8_7 04:36:53 INFO - 2015-11-23 04:36:53,671 DEBUG : operating with platform_type : mac_ 04:36:53 INFO - 2015-11-23 04:36:53,671 INFO : Initialising browser for v8_7 test... 04:36:53 INFO - 2015-11-23 04:36:53,686 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpjn1bNw/profile http://localhost:49462/getInfo.html 04:36:56 INFO - 2015-11-23 04:36:56,011 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:36:56 INFO - 2015-11-23 04:36:56,011 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:36:56 INFO - 2015-11-23 04:36:56,011 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:36:56 INFO - 2015-11-23 04:36:56,011 DEBUG : BROWSER_OUTPUT: __metrics 04:36:56 INFO - 2015-11-23 04:36:56,027 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:56 INFO - 2015-11-23 04:36:56,699 INFO : Browser initialized. 04:36:56 INFO - 2015-11-23 04:36:56,699 INFO : Running cycle 1/1 for v8_7 test... 04:36:56 INFO - 2015-11-23 04:36:56,699 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpjn1bNw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:37:08 INFO - 2015-11-23 04:37:08,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 198860800 04:37:08 INFO - 2015-11-23 04:37:08,645 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49462/tests/v8_7/run.html (next: http://localhost:49462/tests/v8_7/run.html) 04:37:31 INFO - 2015-11-23 04:37:31,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 518500352 04:37:31 INFO - 2015-11-23 04:37:31,756 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,756 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:31 INFO - 2015-11-23 04:37:31,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:31 INFO - 2015-11-23 04:37:31,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:31 INFO - 2015-11-23 04:37:31,757 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:31 INFO - 2015-11-23 04:37:31,758 DEBUG : BROWSER_OUTPUT: |0;Richards;179.62996227770793 04:37:31 INFO - 2015-11-23 04:37:31,758 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;203.95676116663267 04:37:31 INFO - 2015-11-23 04:37:31,758 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.92544335866813 04:37:31 INFO - 2015-11-23 04:37:31,758 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6382.165605095542 04:37:31 INFO - 2015-11-23 04:37:31,758 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1145.3089244851258 04:37:31 INFO - 2015-11-23 04:37:31,758 DEBUG : BROWSER_OUTPUT: |5;Earley;762.1951219512196 04:37:31 INFO - 2015-11-23 04:37:31,759 DEBUG : BROWSER_OUTPUT: |6;Boyer;13986.111111111111 04:37:31 INFO - 2015-11-23 04:37:31,759 DEBUG : BROWSER_OUTPUT: |7;RegExp;32629.032258064515 04:37:31 INFO - 2015-11-23 04:37:31,759 DEBUG : BROWSER_OUTPUT: |8;Splay;682.7773995915588 04:37:31 INFO - 2015-11-23 04:37:31,759 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6435.897435897436 04:37:31 INFO - 2015-11-23 04:37:31,759 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:31 INFO - 2015-11-23 04:37:31,759 DEBUG : BROWSER_OUTPUT: __startTimestamp1448282251755__endTimestamp 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:179.63 Median:179.63 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: Values: 179.6 04:37:31 INFO - 2015-11-23 04:37:31,760 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,761 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:203.96 Median:203.96 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,761 DEBUG : BROWSER_OUTPUT: Values: 204.0 04:37:31 INFO - 2015-11-23 04:37:31,761 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,761 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.93 Median:361.93 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: Values: 361.9 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6382.17 Median:6382.17 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: Values: 6382.2 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1145.31 Median:1145.31 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: Values: 1145.3 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:762.20 Median:762.20 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: Values: 762.2 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13986.11 Median:13986.11 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: Values: 13986.1 04:37:31 INFO - 2015-11-23 04:37:31,762 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32629.03 Median:32629.03 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: Values: 32629.0 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:682.78 Median:682.78 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: Values: 682.8 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6435.90 Median:6435.90 stddev:0.00 (0.0%) 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: Values: 6435.9 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:31 INFO - 2015-11-23 04:37:31,763 DEBUG : BROWSER_OUTPUT: 04:37:32 INFO - 2015-11-23 04:37:32,416 INFO : Browser exited with error code: 0 04:37:32 INFO - 2015-11-23 04:37:32,438 INFO : Completed test v8_7 (00:00:38) 04:37:32 INFO - 2015-11-23 04:37:32,522 INFO : Completed test suite (00:20:13) 04:37:32 INFO - 2015-11-23 04:37:32,522 DEBUG : Working with test: dromaeo_css 04:37:32 INFO - 2015-11-23 04:37:32,522 DEBUG : Generating results file: dromaeo_css 04:37:32 INFO - 2015-11-23 04:37:32,523 DEBUG : Working with test: kraken 04:37:32 INFO - 2015-11-23 04:37:32,523 DEBUG : Generating results file: kraken 04:37:32 INFO - 2015-11-23 04:37:32,523 INFO : javascript benchmark 04:37:32 INFO - 2015-11-23 04:37:32,524 DEBUG : Working with test: v8_7 04:37:32 INFO - 2015-11-23 04:37:32,524 DEBUG : Generating results file: v8_7 04:37:32 INFO - 2015-11-23 04:37:32,524 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:32 INFO - 2015-11-23 04:37:32,593 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 04:37:32 INFO - 2015-11-23 04:37:32,594 DEBUG : process_Request line: dromaeo_css 6287.97 graph.html#tests=[[72,52,55]] 04:37:32 INFO - 2015-11-23 04:37:32,594 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:32 INFO - 2015-11-23 04:37:32,639 DEBUG : process_Request line: kraken 1691.20 graph.html#tests=[[232,52,55]] 04:37:32 INFO - 2015-11-23 04:37:32,639 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:32 INFO - 2015-11-23 04:37:32,670 DEBUG : process_Request line: v8_7 18316.28 graph.html#tests=[[230,52,55]] 04:37:32 INFO - 2015-11-23 04:37:32,671 INFO : javascript benchmark 04:37:32 INFO - 2015-11-23 04:37:32,673 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [320.9759268054895, 321.7506432514802, 326.79738562091507, 330.17291684330746, 330.7684620765465, 13528.18830870146, 13957.371918263678, 15766.763498547516, 16330.83669163308, 17010.82989170108, 13290.933545332284, 13976.790348144787, 15502.147381893992, 16242.431514896982, 16323.755143672824, 4372.103718737659, 5074.264231686403, 5089.0, 5104.464031276718, 5106.668066575679, 3703.703703703697, 4950.430700469438, 4999.475055119215, 5002.77487513061, 5011.0, 4902.828401005965, 5486.533644640211, 5492.395836457987, 5496.835094947158, 5507.504324610784, 5322.33470816148, 5415.783368665248, 5456.890862182754, 5480.671159730429, 5508.338999320067, 4834.154023045953, 4843.830465933711, 4847.466778654345, 4851.975740121312, 4860.3195552622665, 19639.410817675493, 19940.60118797616, 19975.600487990305, 20284.391468255977, 20397.38807835767, 1863.2640107157733, 1866.5371424039972, 1881.9717704234447, 2040.4694779357326, 2056.5578400643785, 12205.267683938904, 12659.810102848465, 12713.237205767684, 12902.290374029424, 13064.412101455457, 1437.5112461762947, 1531.111955066059, 1531.3415231450472, 1574.9527514174592, 1575.3226112771504, 57265.713671431375, 57724.0, 57972.71013644947, 58505.0, 58646.41353586495, 9025.277977761763, 9297.628094876265, 9358.4384936904, 9390.718278451657, 9405.811883762286, 11347.148963827582, 11387.601433949938, 11439.88560114405, 11461.255018423775, 11474.598389056342, 7703.807404814925, 7711.305982461606, 7761.883571746315, 7830.882536761953, 7841.2158784122275, 7957.7612671619945, 8007.759767206877, 8015.038195416588, 8022.83954320922, 8027.15714849944, 5492.286002819687, 5510.504054635022, 5551.72241387929, 5562.833115006556, 5617.241672374177, 1478.3569147420692, 1568.0199875078076, 1578.447543359838, 1593.8645215156841, 1597.3530720058395, 802.3821657323828, 862.8058686795546, 905.7011186308503, 920.995395023034, 995.7460847483845, 16674.166291685367, 17037.14814259282, 17405.738913916302, 17444.563885902953, 17484.038377889083, 772.2817779465151, 869.5912920927154, 876.9517676527724, 913.2921985461321, 929.2008872369756, 5077.416097148801, 5196.45437229093, 5206.505381988705, 8838.204561589488, 9429.90570094304, 504319.0, 508879.1004404811, 519132.0, 523569.0, 573926.0, 74465.0, 74600.25399746042, 75312.0, 75485.0, 75736.62131689416, 387.81772566893517, 389.68435567190664, 389.7564022485946, 389.8089935931373, 390.49235993208714, 8502.787430314043, 8786.692465763668, 9042.593083311136, 9075.092490751136, 9075.455472671661, 34389.0, 34601.30797383988, 34895.65104349026, 35073.29853402969, 35491.64508354987, 42741.0, 46950.0, 47002.059958799946, 47966.28050579314, 48038.0, 7035.788926332013, 7420.183779784112, 7437.739679111205, 7446.590437525988, 7449.366803821519, 10732.356058636507, 10921.672349829518, 10959.945200273947, 11207.551697931991, 11229.045531129945, 9530.809383812424, 9587.664431744855, 9681.177099946583, 9787.314887957775, 9824.312298139062, 9137.131972462605, 9268.073192680678, 9368.297377696565, 9381.061893810564, 9403.529823508934, 7595.430342724208, 9110.134537218953, 9178.449293042439, 9547.522623868917, 9594.520273986132, 6660.533762636569, 7285.2714728528845, 7441.0, 7453.925460745323, 7515.586642734702, 9573.473458959825, 9759.316847820868, 9767.21862251004, 9801.803963920824, 9860.0], "dojo.html": [2862.7280408361203, 2937.280366310253, 2940.8676609552563, 2949.4838403279423, 2974.0185738706214, 4773.116973359926, 4824.710517368961, 4834.08152451034, 4845.515448455153, 4910.852674419764, 4858.659893807426, 4888.120138375091, 4945.134601444751, 4960.950390496094, 4965.28003439501, 4492.505824359318, 4604.309353596954, 4661.813527458898, 4666.183417901871, 4675.953240467586, 4697.154512187805, 4710.882227944295, 4734.644901632374, 4737.242041273397, 4783.832565860195, 4620.676552641316, 4642.187617166982, 4686.7656617169005, 4697.553732395417, 4722.763861806913, 4565.611922986567, 4650.116477869194, 4671.11248862715, 4704.200285951362, 4739.312799644067, 4639.002614437912, 4674.672772905898, 4719.9292010619865, 4739.881502962419, 4755.0489902019735, 4677.74272415017, 4776.5701086902345, 4784.545468180518, 4882.975585122087, 4929.8028078876805, 5134.5378915897745, 5223.686578805284, 5237.711925844077, 5275.894482110375, 5292.92060619091, 5301.416844147179, 5301.973490132525, 5355.919661205085, 5401.594880383947, 5401.972990135064, 4778.904421911542, 4875.609951203895, 4963.932754457809, 4983.501649834988, 5035.169197082477, 5256.26412302278, 5352.545033672103, 5394.622376433612, 5396.082665946798, 5411.918821217685, 5140.665856719302, 5150.304708864255, 5153.330067091254, 5166.457521960216, 5182.611304152204, 4956.256561515802, 5067.619928505377, 5113.821016264487, 5340.0, 5359.812406565829, 5099.6685215460875, 5163.251328557338, 5174.301469301671, 5191.143461328914, 5212.478752124833, 5183.688978661293, 5255.5532779713385, 5299.549538289211, 5303.681779093266, 5341.65279256847, 3989.900252493711, 4118.155778065489, 4126.628603425706, 4140.254754144283, 4170.103427763045, 3585.1933315003917, 3594.67647911684, 3638.017735211478, 3682.0, 3746.026033231325, 5019.0463811875625, 5022.221555658879, 5064.316317297192, 5095.31213286209, 5105.208692652571, 4982.3522942018035, 5078.873028174326, 5145.871353216125, 5390.299261096111, 5396.163594642837, 4887.193613053877, 4943.604511639132, 5016.398032236155, 5023.723695196799, 5063.240513922868, 4576.8626941191815, 4585.839495617637, 4619.6073333766335, 4622.86131416058, 4645.396098507173, 5168.198929165986, 5271.077561426659, 5327.893442131136, 5373.4357892422295, 5384.0, 5219.556337711185, 5309.389420216725, 5338.3060202173465, 5339.7063161526485, 5340.198970154508, 5365.7048862311385, 5472.343318801769, 5494.0, 5497.780088796403, 5505.614606977473, 5114.667546609458, 5204.843854684365, 5258.553022992935, 5293.47065293483, 5362.758675859518, 5335.866603334947, 5426.240326354235, 5451.018816613047, 5451.209574611738, 5462.890742185214, 5243.213517972335, 5249.501297376743, 5304.734763261744, 5318.441563635917, 5325.387580428301, 4981.10340138764, 5081.4918508148885, 5131.0, 5197.66215196011, 5286.286351342519, 4878.243872199673, 4962.131626965194, 4983.0, 4985.252212168204, 4992.326035985096, 5037.596992240538, 5251.973740131275, 5286.365636123536, 5305.31030965972, 5306.230596563554, 4932.901341973212, 5084.2627818966785, 5087.592992560512, 5161.277421160966, 5174.7153906535505], "mootools.html": [1244.2347956007059, 1538.3000734665727, 1627.8930327377382, 1637.5742307000185, 1673.1801417305524, 6574.934250657498, 6815.931840681598, 6851.520393572452, 6921.204061532912, 6953.687084081216, 7108.999999999987, 7153.928460715391, 7162.247963963787, 7165.534240274392, 7204.0, 1741.329588108581, 1804.6210295837889, 2015.2745011795778, 2037.663785475395, 2048.9180432782746, 2019.4951262184454, 2078.667413213886, 2081.698153767703, 2092.9790702092937, 2093.434772611394, 2004.7995200479982, 2005.2580545198225, 2028.0, 2055.486128467883, 2074.4502706782714, 2003.2187446895723, 2010.919563217477, 2012.2755807909286, 2035.9287424940205, 2044.0903797810056, 1979.7822239553639, 1998.560316730317, 2003.9098240579208, 2015.083137172583, 2017.3040301096098, 7033.296670332977, 7049.718011279542, 7059.50583459158, 7100.254473280334, 7125.358717715379, 4350.8912277193, 4410.294352903552, 4423.203823311803, 4452.287633978548, 4454.420925279693, 2536.606825941982, 2650.9204723858124, 2652.840829550233, 2656.53510635638, 2668.906588269421, 680.829792551862, 728.1371574684016, 737.6053811210976, 738.785752131881, 793.5080250244828, 9443.15011648948, 9459.905400945903, 9501.762455938588, 9515.857262141073, 9531.428114313163, 3907.1404291055924, 4008.4788977432745, 4033.092554175346, 4062.3297155969526, 4072.735272207297, 8453.95773021131, 8477.448965817326, 8509.74470765878, 8519.190676885686, 8523.95738021306, 4445.955540444555, 4462.687611867138, 4490.101979604092, 4509.774511274423, 4515.0, 4071.4096456013713, 4086.5504794472586, 4099.631033206966, 4114.444549985774, 4114.670826333946, 3423.845926933294, 3450.016745227598, 3497.4928635347733, 3502.422100353413, 3525.682688558042, 1081.221520505235, 1100.7908497385472, 1103.1230172013268, 1110.8111621024445, 1115.642994241835, 918.5499105438287, 920.1580553793204, 923.2337160157053, 1126.695792136135, 1165.81929800881, 6542.542022058506, 6548.3779040991985, 6559.114519539801, 6906.620135892575, 7066.222715501291, 1051.747580580655, 1060.4909643371225, 1066.2482949520725, 1070.2347821307803, 1080.9729756755987, 5090.0, 5096.311997880312, 5110.872228194325, 5111.821086262037, 5159.355080614923, 8032.39757018226, 8455.112213217646, 8458.87311690325, 8591.44155629882, 8600.053994060649, 8147.348212143014, 8301.709440169565, 8433.873491897626, 8450.154984501623, 8485.109063548362, 6630.071789949411, 6679.332066793282, 6693.297203793629, 6739.292374300726, 6748.055272261888, 6502.60984340941, 6656.068150459037, 6702.631355275312, 6725.529212955046, 6743.022261772114, 7517.1731109579, 7571.545707257582, 7585.2035536270105, 7629.6566654499575, 7647.120581133018, 7622.885656715042, 7759.379249660126, 7815.687372505036, 7830.177831327628, 7859.4891332063235, 6118.571699980958, 6198.690065496798, 6214.40963108504, 6241.500679945502, 6243.594166379171, 6786.355296246848, 6977.0, 7023.894641580483, 7038.8944165838575, 7062.293770622897, 6216.53375996793, 6354.841128971812, 6385.616862988236, 6401.903971440339, 6591.406773390418, 6104.481119104926, 6172.783952561639, 6408.807735767934, 6494.413062097396, 6500.219973603198, 5779.739911703899, 6071.119687645355, 6120.418560236771, 6132.846678833065, 6608.140941677551, 5732.57005724564, 5735.0537161369575, 5740.827775166752, 5794.391588883106, 5795.652260864362, 5427.294451721251, 5892.263467066617, 5895.086261629454, 5917.970410147922, 5921.14143449206], "ext.html": [522.5871561466441, 523.0663266070065, 528.595624347374, 534.2520471340122, 550.865038065674, 28937.565936510942, 31243.531347029813, 38049.80975095121, 38113.809430952875, 38532.22935541288, 40460.0, 40908.79545602275, 41054.794726026405, 41107.794461027726, 41149.58850411495, 7851.254130857559, 8432.198941100602, 8659.437136586133, 8672.219500244977, 8706.129387061275, 7862.921370786305, 10133.138683211935, 10353.430561319163, 10409.68770936873, 10428.582856685724, 10069.69790906274, 10191.490425478734, 10217.131543818747, 10232.386056836576, 10232.641857534987, 8002.5998700064765, 8200.876986845202, 10165.288429809916, 10222.131118854906, 10241.641542546013, 10039.89960100397, 10106.696799096038, 10123.89876101237, 10141.2394070445, 10158.441285729283, 37172.0, 37827.0, 37948.62051379478, 37989.43015854764, 38079.809600952096, 2637.0902038796585, 2658.548046832024, 2684.704682484925, 2946.1603443018635, 3102.9224269393444, 25590.0, 25883.611745823826, 26311.21066368012, 26412.339691507674, 26729.33176670599, 2125.415510734545, 2220.3338998300446, 2225.7329120505483, 2250.9774902250933, 2277.10054528462, 266297.0, 266790.0, 267034.0, 267649.0, 268154.999999998, 60579.0, 61039.38960610426, 61050.69474652598, 61083.08375374373, 61483.38516614777, 60932.39067609356, 63237.683811580646, 70615.64692176506, 72410.0, 72542.2745772546, 16100.75848862268, 16118.032918024956, 16327.183640817912, 16481.76386770997, 16492.350764923412, 12456.688582785322, 12548.749025019632, 12556.686082847818, 12556.748865022648, 12665.36673166338, 19387.127579258966, 19545.902270488557, 19737.802621973595, 19744.0, 19776.110075046658, 7147.463940204401, 7331.596762178025, 7347.155077166088, 7368.668409921566, 7371.483996120327, 839.345310657688, 884.1644645809648, 921.4563407589554, 1004.8241557727368, 1022.5194158745378, 24635.0, 25007.62488562673, 25151.24546263615, 25749.613755793678, 26362.736372636027, 874.1110629369994, 958.6021800952666, 1064.4837253931837, 1072.6484629366898, 1162.4478372773035, 13204.60386188416, 13797.10318829273, 13964.650883727785, 14596.416143354147, 14823.481178158712, 305273.0, 310980.0, 313719.0, 313955.0, 314900.0, 44393.55606443959, 45321.54678453173, 51350.0, 53882.7305863476, 54204.45795542073, 1314.6713321669583, 1323.0209644862732, 1323.7352529493946, 1332.427056365772, 1336.6391074409855, 24697.0, 25187.24438266855, 25725.228243152735, 25732.356691082874, 26881.86559067192, 43098.0, 44510.77744611256, 48450.5154948446, 50101.49898500968, 50226.0, 243743.0, 243809.0, 247352.0, 250151.0, 250328.0, 28598.57102143428, 28642.85678571594, 29149.85425072861, 29287.0, 29724.405511890072, 39023.609763903136, 40791.1841763169, 40856.59143408647, 41221.1755764877, 42000.57999419967, 32959.340813184084, 34386.0, 34618.0, 34838.65161348455, 35132.12169695778, 33177.83411082929, 33323.500147497325, 33922.66077339195, 33995.15012124618, 34452.0, 33757.0, 34348.48477272893, 34612.82693586516, 34691.0, 34694.65305347015, 29783.0, 30137.246568835955, 30400.239994000327, 30410.695893041673, 30439.239019024702, 22481.887590561942, 22487.662685060066, 22539.22259380197, 22624.66063009089, 22840.428989275402], "prototype.html": [287.7453453693481, 305.50965700051415, 305.625608629429, 308.27862801045546, 309.6006152063838, 5608.775648974036, 5615.943840561604, 5645.689487078209, 5668.886622267552, 5688.544916406688, 5342.706151161694, 5458.2904222451025, 5467.425920278373, 5533.031719449101, 5603.215549823028, 4381.605655491006, 4386.056997745484, 4388.67084968627, 4390.209762242787, 4426.62373698236, 4191.077962848169, 4384.736915785047, 4401.625861801751, 4430.02539441324, 4434.933475997863, 4221.071364299864, 4273.551277115905, 4349.369341445488, 4351.3690514875325, 4394.0, 4333.588309110645, 4338.110687309094, 4355.0, 4355.73865568067, 4363.127374525107, 3784.129650180474, 3787.16682329887, 3791.8104094795426, 3794.4118661607495, 3796.7152463565344, 5377.6504527206, 5392.4337944515655, 5408.702521361323, 5424.077906755861, 5430.782768689248, 4664.696794708333, 4759.643026772971, 4768.7854046567645, 4776.020915712271, 4782.928256076161, 5802.7098645068, 5806.274215723035, 5824.563157763142, 5828.0, 5830.271216097988, 3914.3737002079815, 3925.391564307537, 3938.1139243669945, 3941.7437866538585, 3952.01199700075, 5957.553183511254, 6027.60820546663, 6102.6948652567635, 6107.72515236811, 6126.632402055891, 3953.486046813896, 3983.6215559521797, 4013.6387725104296, 4019.3569028955226, 4026.214888096793, 4073.2668119738137, 4087.816048277835, 4111.650509706708, 4113.136241389342, 4116.526599441043, 4746.905061898812, 4751.239801631791, 4751.477337492873, 4756.191447453941, 4765.833195838129, 5770.798022069207, 5773.134029895549, 5810.389909059572, 5828.125781132864, 5843.707814609253, 1450.4560789703862, 1470.852914708542, 1475.837657857635, 1484.5694748522808, 1485.123776971592, 940.9670661526814, 941.270515350595, 959.596969272907, 960.5677445149711, 962.225408546113, 5619.241402410704, 5630.577706672016, 5657.43425657431, 5671.234383358194, 5699.572532060112, 6113.786017489367, 6120.44915957566, 6122.081687746784, 6122.357152499013, 6151.077338399186, 5482.890342193134, 5548.500634942875, 5565.860853478695, 5639.069553523623, 5647.011772939802, 3335.0161702297883, 3349.815760133216, 3355.966440335614, 3356.9328613427597, 3369.157710572357, 6101.267847858197, 6105.0, 6110.847228819226, 6119.571629985947, 6123.020316749388, 6023.367546407564, 6169.660668663267, 6184.319724830265, 6207.162033125561, 6230.626162430269, 6175.073738939195, 6202.162708034358, 6207.5654704171175, 6219.440250377488, 6236.563440559117, 6148.723307451265, 6172.598781079216, 6193.0, 6204.534659900435, 6234.220722409699, 5904.3210030847, 5998.520118390431, 6064.302605200459, 6075.027995520695, 6083.513318934563, 6220.564560480723, 6226.937730622817, 6231.781887633911, 6240.313565507699, 6244.188255526752, 3921.8039098044414, 3929.174873276644, 3944.6055394460323, 3959.980200098981, 3960.4851369322955, 6157.138000679819, 6167.229096362955, 6186.1339412483185, 6188.350223226496, 6209.751609935552, 5882.852928676817, 5958.702064896651, 5959.374265702038, 5967.104934259895, 5993.790217342372, 5937.0, 5949.137375080502, 5953.851153721192, 5958.940410596012, 5964.015937370459, 5723.570732195185, 5738.311402631711, 5755.251817263729, 5767.798127065533, 5785.190073389645, 5780.450857168562, 5967.104934259895, 6019.247594050744, 6020.277566692025, 6034.155218269358, 5824.097264923944, 5844.4155584442915, 5886.23478947734, 5886.646801191942, 5892.027815410409], "yui.html": [579.8608333999839, 668.9866202675946, 676.8037269191934, 680.9285025072368, 686.99012451696, 12089.576864809722, 12392.566260180884, 12405.813912791315, 12438.44027018784, 12443.315617641027, 12949.80575291369, 13280.667983300422, 13397.062205645609, 13408.463661453554, 13459.663508412295, 670.540679634452, 672.2235817630644, 815.3966065111804, 818.378032695153, 830.8836762853175, 818.8239528501371, 823.0288259853371, 823.0575990490885, 827.2843989948681, 828.5484410995991, 836.1721895323616, 839.102160688064, 843.6456688190974, 845.7589586967715, 851.2381418630322, 687.9896801547981, 690.0270618427993, 838.119974027275, 846.4794151596785, 849.5412477262271, 616.165096294519, 617.9598326108834, 622.1445512420422, 623.3392603839899, 625.1810128731377, 12723.23660580359, 12739.426725797268, 12764.425600847891, 12865.035122365767, 12872.678183045406, 8641.135886411372, 8670.08964058771, 8852.336074794352, 9353.485558294291, 9376.343655944087, 7926.445148839583, 8103.878441823377, 8244.464109832901, 8289.41974061816, 8365.790855228606, 2643.6959749628845, 2672.7995400345053, 2694.6362241097595, 2729.0175536806732, 2816.4226333601564, 43630.78184609057, 43828.56171438277, 44180.11639767187, 44200.0, 44293.55706442959, 5730.828075157752, 5820.621659592113, 5948.494377977834, 6094.939050609437, 6162.921488739453, 10301.381917084998, 10333.586656533806, 10341.431221282752, 10356.378617282988, 10380.06579407857, 5110.28456016158, 5151.0470562945975, 5161.045206636709, 5293.920591191135, 5422.8373148805595, 3433.364827506919, 3440.088376580158, 3457.1702791330404, 3468.115630514253, 3600.855965761393, 2291.4042348989383, 2313.2944451941985, 2316.8262380321544, 2320.6751054852334, 2321.814254859607, 357.14285714285404, 364.02622983519507, 371.03345784232226, 375.44809130578005, 376.12738446803155, 399.86204759357975, 400.62275021568456, 450.1919055295752, 514.6011840823317, 534.3907944942769, 6625.834354141089, 6655.0, 6790.151007959494, 6944.791656250321, 7066.893996590055, 385.6336480343685, 390.39878586976306, 431.77763451822335, 477.4867017955642, 481.301200275881, 2914.198595386286, 3055.205646531918, 3128.202308411386, 3150.700683435116, 3150.7164355207683, 56791.432085678614, 57104.42895571074, 57468.0, 57606.71196644074, 57784.4221557779, 49028.509714903106, 49053.018939621725, 49209.0, 49315.26027109596, 49653.751731241835, 42695.57304426978, 43113.784431078275, 43778.0, 43836.0, 43989.90025249458, 6275.058741188675, 6360.77737279193, 6436.324185960594, 6514.348565143448, 7466.216047315171, 32011.679883200868, 32306.35387292288, 32796.508052378755, 32950.0, 33022.83488582542, 42200.36699449449, 42706.57293427026, 43259.783701081295, 43707.56292437035, 43982.78008609937, 6282.057691346335, 6329.30377658448, 6435.485161187187, 6540.803775886731, 6704.296048914794, 9832.213422926006, 9891.2581556385, 10175.592976280866, 10449.05958463742, 10487.37075775456, 9532.809343812945, 9655.951720241354, 9717.514124293615, 9759.219262459128, 9776.511174441392, 9744.658936937172, 9745.707628771148, 9825.705228843146, 9834.065763752433, 9854.507274636382, 9400.858987115336, 9441.386309889835, 9576.186024188022, 9664.661736839176, 9672.177864881563, 8097.352211822922, 8246.876296855431, 8290.87563686533, 8487.0, 8663.220310172115, 7750.7674769756995, 7776.416768742254, 7924.247196516321, 8117.675292988214, 8196.42625016243]}, "summary": {"suite": 6287.967525846819, "subtests": {"jquery.html": {"filtered": 7632.649942868722, "value": 7632.649942868722}, "dojo.html": {"filtered": 4895.318028468237, "value": 4895.318028468237}, "mootools.html": {"filtered": 4066.4235355254045, "value": 4066.4235355254045}, "ext.html": {"filtered": 17700.611529784153, "value": 17700.611529784153}, "prototype.html": {"filtered": 4424.735887302471, "value": 4424.735887302471}, "yui.html": {"filtered": 5193.653185618903, "value": 5193.653185618903}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0031"}, "testrun": {"date": 1448281039, "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": "20151123032726", "branch": "Mozilla-Aurora", "revision": "79c9f80eeeb878601c2a9d01a805cda47dfede1f"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 179.0, 180.0, 182.0, 182.0, 181.0, 180.0, 180.0, 181.0, 188.0], "ai-astar": [115.0, 113.0, 113.0, 120.0, 123.0, 124.0, 132.0, 123.0, 120.0, 120.0], "imaging-gaussian-blur": [136.0, 131.0, 142.0, 130.0, 135.0, 129.0, 135.0, 135.0, 137.0, 135.0], "audio-beat-detection": [173.0, 149.0, 216.0, 207.0, 145.0, 163.0, 140.0, 180.0, 171.0, 144.0], "json-stringify-tinderbox": [70.0, 73.0, 74.0, 75.0, 78.0, 79.0, 76.0, 76.0, 75.0, 76.0], "stanford-crypto-pbkdf2": [165.0, 166.0, 152.0, 156.0, 166.0, 152.0, 164.0, 164.0, 170.0, 169.0], "json-parse-financial": [59.0, 70.0, 71.0, 72.0, 70.0, 72.0, 73.0, 80.0, 64.0, 65.0], "stanford-crypto-sha256-iterative": [73.0, 75.0, 77.0, 79.0, 78.0, 77.0, 77.0, 80.0, 81.0, 81.0], "audio-fft": [89.0, 89.0, 86.0, 136.0, 77.0, 80.0, 81.0, 78.0, 135.0, 73.0], "imaging-darkroom": [140.0, 140.0, 146.0, 140.0, 140.0, 140.0, 140.0, 140.0, 140.0, 140.0], "stanford-crypto-ccm": [145.0, 142.0, 141.0, 129.0, 143.0, 140.0, 148.0, 151.0, 135.0, 139.0], "audio-oscillator": [110.0, 113.0, 154.0, 103.0, 104.0, 101.0, 144.0, 99.0, 99.0, 146.0], "stanford-crypto-aes": [91.0, 92.0, 97.0, 96.0, 94.0, 94.0, 92.0, 93.0, 93.0, 103.0], "imaging-desaturate": [115.0, 118.0, 113.0, 113.0, 119.0, 114.0, 112.0, 114.0, 118.0, 116.0]}, "summary": {"suite": 1691.2, "subtests": {"audio-fft": {"filtered": 92.4, "value": 92.4}, "stanford-crypto-pbkdf2": {"filtered": 162.4, "value": 162.4}, "audio-beat-detection": {"filtered": 168.8, "value": 168.8}, "stanford-crypto-ccm": {"filtered": 141.3, "value": 141.3}, "imaging-darkroom": {"filtered": 140.6, "value": 140.6}, "json-parse-financial": {"filtered": 69.6, "value": 69.6}, "audio-oscillator": {"filtered": 117.3, "value": 117.3}, "ai-astar": {"filtered": 120.3, "value": 120.3}, "audio-dft": {"filtered": 181.3, "value": 181.3}, "stanford-crypto-sha256-iterative": {"filtered": 77.8, "value": 77.8}, "json-stringify-tinderbox": {"filtered": 75.2, "value": 75.2}, "imaging-gaussian-blur": {"filtered": 134.5, "value": 134.5}, "stanford-crypto-aes": {"filtered": 94.5, "value": 94.5}, "imaging-desaturate": {"filtered": 115.2, "value": 115.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0031"}, "testrun": {"date": 1448281039, "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": "20151123032726", "branch": "Mozilla-Aurora", "revision": "79c9f80eeeb878601c2a9d01a805cda47dfede1f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [203.95676116663267], "Encrypt": [361.92544335866813], "NavierStokes": [6435.897435897436], "Decrypt": [6382.165605095542], "Splay": [682.7773995915588], "Richards": [179.62996227770793], "RegExp": [32629.032258064515], "Earley": [762.1951219512196], "Boyer": [13986.111111111111], "RayTrace": [1145.3089244851258]}, "summary": {"suite": 18316.279054006784, "subtests": {"DeltaBlue": {"filtered": 324.17655399999995, "value": 324.17655399999995}, "Encrypt": {"filtered": 735.4581030000003, "value": 735.4581030000003}, "NavierStokes": {"filtered": 230.58167330677296, "value": 230.58167330677296}, "Decrypt": {"filtered": 41.707002994011944, "value": 41.707002994011944}, "Splay": {"filtered": 119.35222233300105, "value": 119.35222233300105}, "RegExp": {"filtered": 27.919461196243212, "value": 27.919461196243212}, "Richards": {"filtered": 196.526234, "value": 196.526234}, "Earley": {"filtered": 874.3994559999996, "value": 874.3994559999996}, "Boyer": {"filtered": 47.65177358490565, "value": 47.65177358490565}, "RayTrace": {"filtered": 646.104281718282, "value": 646.104281718282}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0031"}, "testrun": {"date": 1448281039, "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": "20151123032726", "branch": "Mozilla-Aurora", "revision": "79c9f80eeeb878601c2a9d01a805cda47dfede1f"}}] 04:37:32 INFO - RETURN: dromaeo_css: 6287.97 04:37:32 INFO - RETURN: kraken: 1691.20 04:37:32 INFO - RETURN: v8_7: 18316.28 04:37:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18316.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1691.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6287.97"}}} 04:37:32 INFO - Return code: 0 04:37:32 INFO - # TBPL SUCCESS # 04:37:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:32 INFO - 2015-11-23 04:37:32.798 screenresolution[1988:11649] starting screenresolution argv=screenresolution get 04:37:32 INFO - 2015-11-23 04:37:32.802 screenresolution[1988:11649] Display 0: 1600x1200x32@60 04:37:32 INFO - 2015-11-23 04:37:32.808 screenresolution[1989:11652] starting screenresolution argv=screenresolution list 04:37:32 INFO - Available Modes on Display 0 04:37:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:33 INFO - Intel HD Graphics 3000: 04:37:33 INFO - Chipset Model: Intel HD Graphics 3000 04:37:33 INFO - Type: GPU 04:37:33 INFO - Bus: Built-In 04:37:33 INFO - VRAM (Total): 512 MB 04:37:33 INFO - VRAM (Dynamic, Max): 10 04:37:33 INFO - Vendor: Intel (0x8086) 04:37:33 INFO - Device ID: 0x0116 04:37:33 INFO - Revision ID: 0x0009 04:37:33 INFO - Displays: 04:37:33 INFO - Display: 04:37:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:33 INFO - Display Serial Number: 1600x1200 60 04:37:33 INFO - Main Display: Yes 04:37:33 INFO - Mirror: Off 04:37:33 INFO - Online: Yes 04:37:33 INFO - Rotation: Supported 04:37:33 INFO - Return code: 0 04:37:33 INFO - Running post-action listener: _resource_record_post_action 04:37:33 INFO - Running post-run listener: _resource_record_post_run 04:37:34 INFO - Total resource usage - Wall time: 1254s; CPU: 30.0%; Read bytes: 2129920; Write bytes: 689207296; Read time: 1095; Write time: 49159 04:37:34 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 333451776; Write bytes: 336498688; Read time: 34064; Write time: 7565 04:37:34 INFO - run-tests - Wall time: 1215s; CPU: 30.0%; Read bytes: 2129920; Write bytes: 342444032; Read time: 1095; Write time: 40741 04:37:34 INFO - Running post-run listener: _upload_blobber_files 04:37:34 INFO - Blob upload gear active. 04:37:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:37:34 INFO - Copying logs to upload dir... 04:37:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.891496 ========= master_lag: 2.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-23 04:37:36.890353) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:37:36.899305) ========= 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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/Odf3n8isQXSbBgKfuWHJkQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.07 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:37:36.981147) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:37:36.981503) ========= 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.kJSV8qzDat/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.LWZMUtiD2A/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.005100 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:37:37.158345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:37:37.158802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:37:37.169089) ========= ========= Total master_lag: 3.11 =========