builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0097 starttime: 1447867478.87 results: success (0) buildid: 20151118034229 builduid: a0b8e7af90c640a0bb1b4e92a3b0d70a revision: 2a339d6b372566faedde8fdc11d7a47d8266be2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.874563) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.875021) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.875370) ========= 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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.006271 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.905647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.905962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.925918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.926214) ========= 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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005097 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.980453) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.980798) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:38.981193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-11-18 09:24:38.983890) ========= 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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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-18 09:24:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.55M=0.002s 2015-11-18 09:24:39 (7.55 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.416215 ========= master_lag: 4.96 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-11-18 09:24:44.361292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:44.361670) ========= 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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.019931 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:44.424402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 09:24:44.424787) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2a339d6b372566faedde8fdc11d7a47d8266be2a --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 2a339d6b372566faedde8fdc11d7a47d8266be2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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-18 09:24:44,502 truncating revision to first 12 chars 2015-11-18 09:24:44,502 Setting DEBUG logging. 2015-11-18 09:24:44,503 attempt 1/10 2015-11-18 09:24:44,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2a339d6b3725?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 09:24:44,766 unpacking tar archive at: mozilla-aurora-2a339d6b3725/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513947 ========= master_lag: 0.62 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 09:24:45.557371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:45.557673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:45.597470) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:45.597719) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 09:24:45.598070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-18 09:24:45.598361) ========= /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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:24:45 INFO - MultiFileLogger online at 20151118 09:24:45 in /builds/slave/test 09:24:45 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 09:24:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:45 INFO - {'append_to_log': False, 09:24:45 INFO - 'base_work_dir': '/builds/slave/test', 09:24:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:24:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:45 INFO - 'branch': 'Mozilla-Aurora', 09:24:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:45 INFO - 'config_files': ('talos/mac_config.py',), 09:24:45 INFO - 'default_actions': ('clobber', 09:24:45 INFO - 'read-buildbot-config', 09:24:45 INFO - 'download-and-extract', 09:24:45 INFO - 'populate-webroot', 09:24:45 INFO - 'create-virtualenv', 09:24:45 INFO - 'install', 09:24:45 INFO - 'run-tests'), 09:24:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:45 INFO - 'download_minidump_stackwalk': True, 09:24:45 INFO - 'download_symbols': 'ondemand', 09:24:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:45 INFO - 'installer_path': 'installer.exe', 09:24:45 INFO - 'log_level': 'info', 09:24:45 INFO - 'log_name': 'talos', 09:24:45 INFO - 'log_to_console': True, 09:24:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:24:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:24:45 INFO - 'opt_config_files': (), 09:24:45 INFO - 'pip_index': False, 09:24:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:45 INFO - 'cmd': ('bash', 09:24:45 INFO - '-c', 09:24:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:45 INFO - 'enabled': True, 09:24:45 INFO - 'halt_on_failure': False, 09:24:45 INFO - 'name': 'check_screen_resolution'},), 09:24:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:45 INFO - 'cmd': ('bash', 09:24:45 INFO - '-c', 09:24:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:45 INFO - 'enabled': True, 09:24:45 INFO - 'halt_on_failure': False, 09:24:45 INFO - 'name': 'check_screen_resolution'},), 09:24:45 INFO - 'run_cmd_checks_enabled': True, 09:24:45 INFO - 'sps_profile': False, 09:24:45 INFO - 'sps_profile_interval': 0, 09:24:45 INFO - 'suite': 'dromaeojs', 09:24:45 INFO - 'system_bits': '64', 09:24:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:45 INFO - 'title': 't-yosemite-r5-0097', 09:24:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:45 INFO - 'use_talos_json': True, 09:24:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:45 INFO - 'work_dir': 'build'} 09:24:45 INFO - ##### 09:24:45 INFO - ##### Running clobber step. 09:24:45 INFO - ##### 09:24:45 INFO - Running pre-action listener: _resource_record_pre_action 09:24:45 INFO - Running main action method: clobber 09:24:45 INFO - rmtree: /builds/slave/test/build 09:24:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:48 INFO - Running post-action listener: _resource_record_post_action 09:24:48 INFO - ##### 09:24:48 INFO - ##### Running read-buildbot-config step. 09:24:48 INFO - ##### 09:24:48 INFO - Running pre-action listener: _resource_record_pre_action 09:24:48 INFO - Running main action method: read_buildbot_config 09:24:48 INFO - Using buildbot properties: 09:24:48 INFO - { 09:24:48 INFO - "properties": { 09:24:48 INFO - "buildnumber": 269, 09:24:48 INFO - "product": "firefox", 09:24:48 INFO - "script_repo_revision": "production", 09:24:48 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 09:24:48 INFO - "repository": "", 09:24:48 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 09:24:48 INFO - "buildid": "20151118034229", 09:24:48 INFO - "slavename": "t-yosemite-r5-0097", 09:24:48 INFO - "pgo_build": "False", 09:24:48 INFO - "basedir": "/builds/slave/test", 09:24:48 INFO - "project": "", 09:24:48 INFO - "platform": "yosemite", 09:24:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:24:48 INFO - "slavebuilddir": "test", 09:24:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:24:48 INFO - "branch": "mozilla-aurora", 09:24:48 INFO - "repo_path": "releases/mozilla-aurora", 09:24:48 INFO - "stage_platform": "macosx64", 09:24:48 INFO - "builduid": "a0b8e7af90c640a0bb1b4e92a3b0d70a", 09:24:48 INFO - "revision": "2a339d6b372566faedde8fdc11d7a47d8266be2a" 09:24:48 INFO - }, 09:24:48 INFO - "sourcestamp": { 09:24:48 INFO - "repository": "", 09:24:48 INFO - "hasPatch": false, 09:24:48 INFO - "project": "", 09:24:48 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:24:48 INFO - "changes": [ 09:24:48 INFO - { 09:24:48 INFO - "category": null, 09:24:48 INFO - "files": [ 09:24:48 INFO - { 09:24:48 INFO - "url": null, 09:24:48 INFO - "name": "https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 09:24:48 INFO - } 09:24:48 INFO - ], 09:24:48 INFO - "repository": "", 09:24:48 INFO - "rev": "2a339d6b372566faedde8fdc11d7a47d8266be2a", 09:24:48 INFO - "who": "cbook@mozilla.com", 09:24:48 INFO - "when": 1447867441, 09:24:48 INFO - "number": 6677877, 09:24:48 INFO - "comments": "Bug 1225004 - Record reason for NS_ERROR_FILE_CORRUPTED in nsLayoutStylesheetCache::LoadSheet in crash reports. r=roc, a=lizzard", 09:24:48 INFO - "project": "", 09:24:48 INFO - "at": "Wed 18 Nov 2015 09:24:01", 09:24:48 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:24:48 INFO - "revlink": "", 09:24:48 INFO - "properties": [ 09:24:48 INFO - [ 09:24:48 INFO - "buildid", 09:24:48 INFO - "20151118034229", 09:24:48 INFO - "Change" 09:24:48 INFO - ], 09:24:48 INFO - [ 09:24:48 INFO - "builduid", 09:24:48 INFO - "a0b8e7af90c640a0bb1b4e92a3b0d70a", 09:24:48 INFO - "Change" 09:24:48 INFO - ], 09:24:48 INFO - [ 09:24:48 INFO - "pgo_build", 09:24:48 INFO - "False", 09:24:48 INFO - "Change" 09:24:48 INFO - ] 09:24:48 INFO - ], 09:24:48 INFO - "revision": "2a339d6b372566faedde8fdc11d7a47d8266be2a" 09:24:48 INFO - } 09:24:48 INFO - ], 09:24:48 INFO - "revision": "2a339d6b372566faedde8fdc11d7a47d8266be2a" 09:24:48 INFO - } 09:24:48 INFO - } 09:24:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 09:24:48 INFO - Running post-action listener: _resource_record_post_action 09:24:48 INFO - ##### 09:24:48 INFO - ##### Running download-and-extract step. 09:24:48 INFO - ##### 09:24:48 INFO - Running pre-action listener: _resource_record_pre_action 09:24:48 INFO - Running main action method: download_and_extract 09:24:48 INFO - mkdir: /builds/slave/test/build/tests 09:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:48 INFO - https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/test_packages.json 09:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/test_packages.json 09:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:24:49 INFO - Downloaded 1149 bytes. 09:24:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:24:49 INFO - Using the following test package requirements: 09:24:49 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:24:49 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 09:24:49 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'jsshell-mac.zip'], 09:24:49 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 09:24:49 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:24:49 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 09:24:49 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 09:24:49 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 09:24:49 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:24:49 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:49 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 09:24:49 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:49 INFO - https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:24:51 INFO - Downloaded 17447614 bytes. 09:24:51 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 09:24:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:24:56 INFO - Return code: 0 09:24:56 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 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:56 INFO - https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:24:58 INFO - Downloaded 17447614 bytes. 09:24:58 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 09:24:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:25:03 INFO - Return code: 0 09:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:03 INFO - https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:25:04 INFO - Downloaded 11131307 bytes. 09:25:04 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 09:25:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:25:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:25:05 INFO - Return code: 0 09:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:05 INFO - https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 09:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:25:08 INFO - Downloaded 107675198 bytes. 09:25:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:25:08 INFO - mkdir: /builds/slave/test/properties 09:25:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:25:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:25:08 INFO - Contents: 09:25:08 INFO - build_url:https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:25:08 INFO - Running post-action listener: _resource_record_post_action 09:25:08 INFO - Running post-action listener: set_extra_try_arguments 09:25:08 INFO - ##### 09:25:08 INFO - ##### Running populate-webroot step. 09:25:08 INFO - ##### 09:25:08 INFO - Running pre-action listener: _resource_record_pre_action 09:25:08 INFO - Running main action method: populate_webroot 09:25:08 INFO - Guessing talos json url... 09:25: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')]} 09:25:08 INFO - https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 09:25:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:25:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:25:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/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 09:25:09 INFO - Downloaded 107 bytes. 09:25:09 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:25:09 INFO - Contents: 09:25:09 INFO - 20151118034229 09:25:09 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/2a339d6b372566faedde8fdc11d7a47d8266be2a 09:25:09 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')]} 09:25:09 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/2a339d6b37/testing/talos/talos.json 09:25:09 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/2a339d6b37/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/2a339d6b37/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:25:09 INFO - Downloaded 4264 bytes. 09:25:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:25:09 INFO - '../fennec_ids.txt'], 09:25:09 INFO - 'tests': ['tcheck2']}, 09:25:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:09 INFO - '--tppagecycles', 09:25:09 INFO - '7'], 09:25:09 INFO - 'tests': ['tsvgm']}}, 09:25:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:25:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:25:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:25:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'tests': ['damp', 'tps']}, 09:25:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['damp', 'tps']}, 09:25:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:25:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:09 INFO - 'other': {'tests': ['a11yr', 09:25:09 INFO - 'ts_paint', 09:25:09 INFO - 'tpaint', 09:25:09 INFO - 'sessionrestore', 09:25:09 INFO - 'sessionrestore_no_auto_restore']}, 09:25:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['a11yr', 09:25:09 INFO - 'ts_paint', 09:25:09 INFO - 'tpaint', 09:25:09 INFO - 'sessionrestore', 09:25:09 INFO - 'sessionrestore_no_auto_restore']}, 09:25:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['a11yr', 09:25:09 INFO - 'ts_paint', 09:25:09 INFO - 'tpaint', 09:25:09 INFO - 'sessionrestore', 09:25:09 INFO - 'sessionrestore_no_auto_restore']}, 09:25:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['a11yr', 09:25:09 INFO - 'ts_paint', 09:25:09 INFO - 'tpaint', 09:25:09 INFO - 'sessionrestore', 09:25:09 INFO - 'sessionrestore_no_auto_restore']}, 09:25:09 INFO - 'other_l64': {'tests': ['a11yr', 09:25:09 INFO - 'ts_paint', 09:25:09 INFO - 'tpaint', 09:25:09 INFO - 'sessionrestore', 09:25:09 INFO - 'sessionrestore_no_auto_restore']}, 09:25:09 INFO - 'other_nol64': {'tests': ['a11yr', 09:25:09 INFO - 'ts_paint', 09:25:09 INFO - 'tpaint', 09:25:09 INFO - 'sessionrestore', 09:25:09 INFO - 'sessionrestore_no_auto_restore']}, 09:25:09 INFO - 'svgr': {'tests': ['tsvgx', 09:25:09 INFO - 'tsvgr_opacity', 09:25:09 INFO - 'tart', 09:25:09 INFO - 'tscrollx', 09:25:09 INFO - 'cart']}, 09:25:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['tsvgx', 09:25:09 INFO - 'tsvgr_opacity', 09:25:09 INFO - 'tart', 09:25:09 INFO - 'tscrollx', 09:25:09 INFO - 'cart']}, 09:25:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'tests': ['tp5o']}, 09:25:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'talos_options': ['--e10s'], 09:25:09 INFO - 'tests': ['tp5o']}, 09:25:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'talos_options': ['--xperf_path', 09:25:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:09 INFO - 'tests': ['tp5n']}, 09:25:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:09 INFO - 'talos_options': ['--e10s', 09:25:09 INFO - '--xperf_path', 09:25:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:25:09 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:25:09 INFO - 'tests': ['tp5n']}}, 09:25:09 INFO - 'talos.zip': {'path': '', 09:25:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:09 INFO - Running post-action listener: _resource_record_post_action 09:25:09 INFO - ##### 09:25:09 INFO - ##### Running create-virtualenv step. 09:25:09 INFO - ##### 09:25:09 INFO - Running pre-action listener: _resource_record_pre_action 09:25:09 INFO - Running main action method: create_virtualenv 09:25:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:25: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 09:25:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:25:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:09 INFO - Using real prefix '/tools/python27' 09:25:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:25:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:15 INFO - Installing pip.................done. 09:25:15 INFO - Return code: 0 09:25:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:15 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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25:15 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 09:25:15 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 09:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:15 INFO - 'HOME': '/Users/cltbld', 09:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:15 INFO - 'LOGNAME': 'cltbld', 09:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:15 INFO - 'MOZ_NO_REMOTE': '1', 09:25:15 INFO - 'NO_EM_RESTART': '1', 09:25:15 INFO - 'PAGER': '/bin/cat', 09:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:15 INFO - 'PWD': '/builds/slave/test', 09:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:15 INFO - 'SHELL': '/bin/bash', 09:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:15 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:15 INFO - 'USER': 'cltbld', 09:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:15 INFO - 'XPC_FLAGS': '0x0', 09:25:15 INFO - 'XPC_SERVICE_NAME': '0', 09:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:15 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 09:25:15 INFO - Cleaning up... 09:25:15 INFO - Return code: 0 09:25:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:15 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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25:15 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 09:25:15 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 09:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:15 INFO - 'HOME': '/Users/cltbld', 09:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:15 INFO - 'LOGNAME': 'cltbld', 09:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:15 INFO - 'MOZ_NO_REMOTE': '1', 09:25:15 INFO - 'NO_EM_RESTART': '1', 09:25:15 INFO - 'PAGER': '/bin/cat', 09:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:15 INFO - 'PWD': '/builds/slave/test', 09:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:15 INFO - 'SHELL': '/bin/bash', 09:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:15 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:15 INFO - 'USER': 'cltbld', 09:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:15 INFO - 'XPC_FLAGS': '0x0', 09:25:15 INFO - 'XPC_SERVICE_NAME': '0', 09:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:15 INFO - Downloading/unpacking psutil>=0.7.1 09:25:15 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 09:25:15 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 09:25:15 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 09:25:15 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 09:25:15 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 09:25:15 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 09:25:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:25:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:18 INFO - Installing collected packages: psutil 09:25:18 INFO - Running setup.py install for psutil 09:25:18 INFO - building 'psutil._psutil_osx' extension 09:25: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:25: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 09:25: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 09:25: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 09:25:18 INFO - building 'psutil._psutil_posix' extension 09:25: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 09:25:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:25:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:25:18 INFO - ^ 09:25:19 INFO - 1 warning generated. 09:25:19 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 09:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:19 INFO - Successfully installed psutil 09:25:19 INFO - Cleaning up... 09:25:19 INFO - Return code: 0 09:25:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25:19 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 09:25:19 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 09:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:19 INFO - 'HOME': '/Users/cltbld', 09:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:19 INFO - 'LOGNAME': 'cltbld', 09:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:19 INFO - 'MOZ_NO_REMOTE': '1', 09:25:19 INFO - 'NO_EM_RESTART': '1', 09:25:19 INFO - 'PAGER': '/bin/cat', 09:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:19 INFO - 'PWD': '/builds/slave/test', 09:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:19 INFO - 'SHELL': '/bin/bash', 09:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:19 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:19 INFO - 'USER': 'cltbld', 09:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:19 INFO - 'XPC_FLAGS': '0x0', 09:25:19 INFO - 'XPC_SERVICE_NAME': '0', 09:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:25:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:25:22 INFO - Installing collected packages: mozsystemmonitor 09:25:22 INFO - Running setup.py install for mozsystemmonitor 09:25:22 INFO - Successfully installed mozsystemmonitor 09:25:22 INFO - Cleaning up... 09:25:22 INFO - Return code: 0 09:25:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25:22 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 09:25:22 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 09:25:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:22 INFO - 'HOME': '/Users/cltbld', 09:25:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:22 INFO - 'LOGNAME': 'cltbld', 09:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:22 INFO - 'MOZ_NO_REMOTE': '1', 09:25:22 INFO - 'NO_EM_RESTART': '1', 09:25:22 INFO - 'PAGER': '/bin/cat', 09:25:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:22 INFO - 'PWD': '/builds/slave/test', 09:25:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:22 INFO - 'SHELL': '/bin/bash', 09:25:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:22 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:22 INFO - 'USER': 'cltbld', 09:25:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:22 INFO - 'XPC_FLAGS': '0x0', 09:25:22 INFO - 'XPC_SERVICE_NAME': '0', 09:25:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:26 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 09:25:26 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 09:25:26 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 09:25:26 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 09:25:26 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 09:25:26 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 09:25:26 INFO - Downloading docopt-0.6.1.tar.gz 09:25:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:26 INFO - Running setup.py install for blobuploader 09:25:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:26 INFO - Running setup.py install for requests 09:25:27 INFO - Running setup.py install for docopt 09:25:27 INFO - Successfully installed blobuploader requests docopt 09:25:27 INFO - Cleaning up... 09:25:27 INFO - Return code: 0 09:25:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:27 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')]} 09:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:27 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')]} 09:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:27 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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25:27 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 09:25:27 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 09:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:27 INFO - 'HOME': '/Users/cltbld', 09:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:27 INFO - 'LOGNAME': 'cltbld', 09:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:27 INFO - 'MOZ_NO_REMOTE': '1', 09:25:27 INFO - 'NO_EM_RESTART': '1', 09:25:27 INFO - 'PAGER': '/bin/cat', 09:25:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:27 INFO - 'PWD': '/builds/slave/test', 09:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:27 INFO - 'SHELL': '/bin/bash', 09:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:27 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:27 INFO - 'USER': 'cltbld', 09:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:27 INFO - 'XPC_FLAGS': '0x0', 09:25:27 INFO - 'XPC_SERVICE_NAME': '0', 09:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:27 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-Zcr8dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:27 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-ngMUo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-fDNcD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-Agimt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-W6lTJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-QUBE9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-NB0zen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-_ls5s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-mhOLfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:28 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-dXYJSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-JMq9IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-H2Vrcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-IcNl95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-AZVpf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-yEbKfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-DFywFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:29 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-MXaxAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:30 INFO - Running setup.py install for manifestparser 09:25:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:30 INFO - Running setup.py install for mozcrash 09:25:30 INFO - Running setup.py install for mozdebug 09:25:30 INFO - Running setup.py install for mozdevice 09:25:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:30 INFO - Running setup.py install for mozfile 09:25:30 INFO - Running setup.py install for mozhttpd 09:25:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozinfo 09:25:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozInstall 09:25:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozleak 09:25:31 INFO - Running setup.py install for mozlog 09:25:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for moznetwork 09:25:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozprocess 09:25:32 INFO - Running setup.py install for mozprofile 09:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for mozrunner 09:25:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for mozscreenshot 09:25:32 INFO - Running setup.py install for moztest 09:25:32 INFO - Running setup.py install for mozversion 09:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:33 INFO - Cleaning up... 09:25:33 INFO - Return code: 0 09:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:33 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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25:33 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 09:25:33 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 09:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:33 INFO - 'HOME': '/Users/cltbld', 09:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:33 INFO - 'LOGNAME': 'cltbld', 09:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:33 INFO - 'MOZ_NO_REMOTE': '1', 09:25:33 INFO - 'NO_EM_RESTART': '1', 09:25:33 INFO - 'PAGER': '/bin/cat', 09:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:33 INFO - 'PWD': '/builds/slave/test', 09:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:33 INFO - 'SHELL': '/bin/bash', 09:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:33 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:33 INFO - 'USER': 'cltbld', 09:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:33 INFO - 'XPC_FLAGS': '0x0', 09:25:33 INFO - 'XPC_SERVICE_NAME': '0', 09:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:33 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-fhg9zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25: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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:33 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-H4aLK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25: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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:33 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-Eyo4gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25: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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:33 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-KUB4hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25: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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:33 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-VXqWM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-cmLMrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-RCRG_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-w2fmxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-i5JDf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25: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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-nsm8hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25: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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-aMtyUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25: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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-25OEzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25: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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:34 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-ZH3QYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:35 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)) 09:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:35 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-yw70MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:35 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)) 09:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:35 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-Sgz9e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:35 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)) 09:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:35 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-Y86wU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:35 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)) 09:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:35 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-pdpGcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25: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)) 09:25: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)) 09:25: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)) 09:25: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)) 09:25: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)) 09:25: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)) 09:25:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:38 INFO - Downloading blessings-1.5.1.tar.gz 09:25:38 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 09:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:38 INFO - Installing collected packages: blessings 09:25:38 INFO - Running setup.py install for blessings 09:25:38 INFO - Successfully installed blessings 09:25:38 INFO - Cleaning up... 09:25:38 INFO - Return code: 0 09:25:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:38 INFO - Reading from file tmpfile_stdout 09:25:38 INFO - Current package versions: 09:25:38 INFO - blessings == 1.5.1 09:25:38 INFO - blobuploader == 1.2.4 09:25:38 INFO - docopt == 0.6.1 09:25:38 INFO - manifestparser == 1.1 09:25:38 INFO - mozInstall == 1.12 09:25:38 INFO - mozcrash == 0.16 09:25:38 INFO - mozdebug == 0.1 09:25:38 INFO - mozdevice == 0.46 09:25:38 INFO - mozfile == 1.2 09:25:38 INFO - mozhttpd == 0.7 09:25:38 INFO - mozinfo == 0.8 09:25:38 INFO - mozleak == 0.1 09:25:38 INFO - mozlog == 3.0 09:25:38 INFO - moznetwork == 0.27 09:25:38 INFO - mozprocess == 0.22 09:25:38 INFO - mozprofile == 0.27 09:25:38 INFO - mozrunner == 6.11 09:25:38 INFO - mozscreenshot == 0.1 09:25:38 INFO - mozsystemmonitor == 0.0 09:25:38 INFO - moztest == 0.7 09:25:38 INFO - mozversion == 1.4 09:25:38 INFO - psutil == 3.1.1 09:25:38 INFO - requests == 1.2.3 09:25:38 INFO - wsgiref == 0.1.2 09:25:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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 0x105185a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d9615430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, '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.uFoAT16VNe/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.TU9noDMosJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 09:25: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 09:25: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 09:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:38 INFO - 'HOME': '/Users/cltbld', 09:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:38 INFO - 'LOGNAME': 'cltbld', 09:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:38 INFO - 'MOZ_NO_REMOTE': '1', 09:25:38 INFO - 'NO_EM_RESTART': '1', 09:25:38 INFO - 'PAGER': '/bin/cat', 09:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:38 INFO - 'PWD': '/builds/slave/test', 09:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:38 INFO - 'SHELL': '/bin/bash', 09:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:25:38 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:38 INFO - 'USER': 'cltbld', 09:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:38 INFO - 'XPC_FLAGS': '0x0', 09:25:38 INFO - 'XPC_SERVICE_NAME': '0', 09:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 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)) 09:25:39 INFO - Cleaning up... 09:25:39 INFO - Return code: 0 09:25:39 INFO - Running post-action listener: _resource_record_post_action 09:25:39 INFO - Running post-action listener: _start_resource_monitoring 09:25:39 INFO - Starting resource monitoring. 09:25:39 INFO - ##### 09:25:39 INFO - ##### Running install step. 09:25:39 INFO - ##### 09:25:39 INFO - Running pre-action listener: _resource_record_pre_action 09:25:39 INFO - Running main action method: install 09:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:39 INFO - Reading from file tmpfile_stdout 09:25:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:39 INFO - Reading from file tmpfile_stdout 09:25:39 INFO - Output received: 09:25:39 INFO - Usage: mozinstall [options] installer 09:25:39 INFO - Options: 09:25:39 INFO - -h, --help show this help message and exit 09:25:39 INFO - -d DEST, --destination=DEST 09:25:39 INFO - Directory to install application into. [default: 09:25:39 INFO - "/builds/slave/test"] 09:25:39 INFO - --app=APP Application being installed. [default: firefox] 09:25:39 INFO - mkdir: /builds/slave/test/build/application 09:25: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'] 09:25: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 09:26:18 INFO - Reading from file tmpfile_stdout 09:26:18 INFO - Output received: 09:26:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:26:18 INFO - Running post-action listener: _resource_record_post_action 09:26:18 INFO - ##### 09:26:18 INFO - ##### Running run-tests step. 09:26:18 INFO - ##### 09:26:18 INFO - Running pre-action listener: _resource_record_pre_action 09:26:18 INFO - Running main action method: run_tests 09:26:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:26:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:26:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:26:18 INFO - 2015-11-18 09:26:18.177 screenresolution[1917:17285] starting screenresolution argv=screenresolution get 09:26:18 INFO - 2015-11-18 09:26:18.181 screenresolution[1917:17285] Display 0: 1600x1200x32@60 09:26:18 INFO - 2015-11-18 09:26:18.187 screenresolution[1918:17287] starting screenresolution argv=screenresolution list 09:26:18 INFO - Available Modes on Display 0 09:26:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:26:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:26:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:26:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:26:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:26:18 INFO - Intel HD Graphics 3000: 09:26:18 INFO - Chipset Model: Intel HD Graphics 3000 09:26:18 INFO - Type: GPU 09:26:18 INFO - Bus: Built-In 09:26:18 INFO - VRAM (Total): 512 MB 09:26:18 INFO - VRAM (Dynamic, Max): 10 09:26:18 INFO - Vendor: Intel (0x8086) 09:26:18 INFO - Device ID: 0x0116 09:26:18 INFO - Revision ID: 0x0009 09:26:18 INFO - Displays: 09:26:18 INFO - Display: 09:26:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:26:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:26:18 INFO - Display Serial Number: 1600x1200 60 09:26:18 INFO - Main Display: Yes 09:26:18 INFO - Mirror: Off 09:26:18 INFO - Online: Yes 09:26:18 INFO - Rotation: Supported 09:26:18 INFO - Return code: 0 09:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:26:18 INFO - Python 2.7.3 09:26:18 INFO - Return code: 0 09:26:18 INFO - grabbing minidump binary from tooltool 09:26: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')]} 09:26: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 0x10513a9f0>, '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 0x104e99cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105104990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:26: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 09:26: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 09:26:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:18 INFO - Return code: 0 09:26:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:26:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:26:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:26:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:26:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:26: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/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] in /builds/slave/test/build 09:26: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/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0097 --webServer localhost 09:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uFoAT16VNe/Render', 09:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:18 INFO - 'HOME': '/Users/cltbld', 09:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:18 INFO - 'LOGNAME': 'cltbld', 09:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:18 INFO - 'MOZ_NO_REMOTE': '1', 09:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:26:18 INFO - 'NO_EM_RESTART': '1', 09:26:18 INFO - 'PAGER': '/bin/cat', 09:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:18 INFO - 'PWD': '/builds/slave/test', 09:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:18 INFO - 'SHELL': '/bin/bash', 09:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU9noDMosJ/Listeners', 09:26:18 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 09:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:18 INFO - 'USER': 'cltbld', 09:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:18 INFO - 'XPC_FLAGS': '0x0', 09:26:18 INFO - 'XPC_SERVICE_NAME': '0', 09:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:26: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/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] with output_timeout 3600 09:26:18 INFO - mozversion INFO | application_buildid: 20151118034229 09:26:18 INFO - mozversion INFO | application_changeset: 2a339d6b372566faedde8fdc11d7a47d8266be2a 09:26:18 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:26:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:18 INFO - mozversion INFO | application_name: Firefox 09:26:18 INFO - mozversion INFO | application_remotingname: firefox-dev 09:26:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:26:18 INFO - mozversion INFO | application_vendor: Mozilla 09:26:18 INFO - mozversion INFO | application_version: 44.0a2 09:26:18 INFO - mozversion INFO | platform_buildid: 20151118034229 09:26:18 INFO - mozversion INFO | platform_changeset: 2a339d6b372566faedde8fdc11d7a47d8266be2a 09:26:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:26:18 INFO - mozversion INFO | platform_version: 44.0a2 09:26:18 INFO - 2015-11-18 09:26:18,805 DEBUG : using testdate: 1447867578 09:26:18 INFO - 2015-11-18 09:26:18,805 DEBUG : actual date: 1447867578 09:26:18 INFO - 2015-11-18 09:26:18,857 INFO : starting webserver on 'localhost:56049' 09:26:18 INFO - 2015-11-18 09:26:18,859 INFO : Starting test suite t-yosemite-r5-0097 09:26:18 INFO - 2015-11-18 09:26:18,859 INFO : Starting test dromaeo_css 09:26:18 INFO - 2015-11-18 09:26:18,859 DEBUG : operating with platform_type : mac_ 09:26:18 INFO - 2015-11-18 09:26:18,860 INFO : Initialising browser for dromaeo_css test... 09:26:18 INFO - 2015-11-18 09:26:18,874 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpBtZDxV/profile http://localhost:56049/getInfo.html 09:26:21 INFO - 2015-11-18 09:26:21,289 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:26:21 INFO - 2015-11-18 09:26:21,289 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:26:21 INFO - 2015-11-18 09:26:21,289 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:26:21 INFO - 2015-11-18 09:26:21,289 DEBUG : BROWSER_OUTPUT: __metrics 09:26:21 INFO - 2015-11-18 09:26:21,305 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:21 INFO - 2015-11-18 09:26:21,996 INFO : Browser initialized. 09:26:21 INFO - 2015-11-18 09:26:21,997 INFO : Running cycle 1/1 for dromaeo_css test... 09:26:21 INFO - 2015-11-18 09:26:21,997 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpBtZDxV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:26:33 INFO - 2015-11-18 09:26:33,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 198959104 09:26:33 INFO - 2015-11-18 09:26:33,991 DEBUG : BROWSER_OUTPUT: 09:27:25 INFO - 2015-11-18 09:27:25,627 DEBUG : BROWSER_OUTPUT: 1447867645624 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] 09:29:35 INFO - 2015-11-18 09:29:35,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56049/tests/dromaeo/cssquery-ext.html) 09:29:37 INFO - 2015-11-18 09:29:37,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 294273024 09:29:37 INFO - 2015-11-18 09:29:37,180 DEBUG : BROWSER_OUTPUT: 09:32:39 INFO - 2015-11-18 09:32:39,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-ext.html (next: http://localhost:56049/tests/dromaeo/cssquery-jquery.html) 09:32:40 INFO - 2015-11-18 09:32:40,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 344944640 09:32:40 INFO - 2015-11-18 09:32:40,333 DEBUG : BROWSER_OUTPUT: 09:35:42 INFO - 2015-11-18 09:35:42,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56049/tests/dromaeo/cssquery-mootools.html) 09:35:43 INFO - 2015-11-18 09:35:43,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 308768768 09:35:43 INFO - 2015-11-18 09:35:43,026 DEBUG : BROWSER_OUTPUT: 09:38:45 INFO - 2015-11-18 09:38:45,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56049/tests/dromaeo/cssquery-prototype.html) 09:38:45 INFO - 2015-11-18 09:38:45,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 300343296 09:38:45 INFO - 2015-11-18 09:38:45,603 DEBUG : BROWSER_OUTPUT: 09:41:48 INFO - 2015-11-18 09:41:48,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56049/tests/dromaeo/cssquery-yui.html) 09:41:49 INFO - 2015-11-18 09:41:49,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 308625408 09:41:49 INFO - 2015-11-18 09:41:49,183 DEBUG : BROWSER_OUTPUT: 09:44:51 INFO - 2015-11-18 09:44:51,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-yui.html (next: http://localhost:56049/tests/dromaeo/cssquery-dojo.html) 09:44:52 INFO - 2015-11-18 09:44:52,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 343740416 09:44:52 INFO - 2015-11-18 09:44:52,021 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:52 INFO - 2015-11-18 09:44:52,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:52 INFO - 2015-11-18 09:44:52,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:52 INFO - 2015-11-18 09:44:52,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:52 INFO - 2015-11-18 09:44:52,022 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2997.145813443169;3009.7140771626714;3042.7565794736424;3145.6382516010653;3181.6659250778666;5091.236314552819;5138.177891537355;5145.3568303962;5190.403103643082;5204.319964865347;5147.356580427447;5151.4333423323405;5181.715005674687;5195.662281951671;5206.739663016843;4650.581447669709;4745.193317136095;4745.73898435585;4786.162421576228;4799.616030717534;4595.747233902151;4633.536646335357;4722.386089808338;4728.929066064012;4738.6446016548725;4755.857324280277;4805.831795887145;4834.178189707741;4838.104950584153;4884.096442158212;4527.207738645757;4792.424909010923;4804.111239420683;4836.322914791932;4866.853994380174;4532.27483602622;4661.906761864778;4662.254039353721;4665.533446655308;4691.3432119503295;5010.223415370623;5113.488651134894;5148.588112950955;5159.922601160985;5170.482951704837;5219.4780521947505;5305.867353316159;5493.972530137364;5515.255440515519;5539.612227144102;5264.078786212397;5352.839414817562;5357.357117145929;5374.6237763356585;5387.138057910715;5007.574356179765;5092.363454568179;5110.897782044375;5118.129917913963;5157.329547158845;5399.244105825188;5527.309086364205;5559.555235581225;5629.577781666391;5647.463490968352;5261.552768014685;5381.542568881689;5387.9461205388225;5420;5430.945690543123;5457.154141108134;5516.117421212667;5522.22688823565;5530.225768392428;5550.47270509301;5180.559652429586;5288.497592728685;5314.4951229633125;5464.316960379952;5496.340439147328;5170.482951704799;5288.286081379041;5291.100512912814;5340.706261155596;5359.812406565751;4068.4710987571425;4157.833686652561;4199.748015119103;4201.34879093741;4232.280512312914;3815.6947444204397;3833.5783063862955;3837.0982819037504;3843.9231215375535;3870.1098747288283;4887.144749668793;5033.3205017322925;5042.3444952156715;5099.821506247264;5199.714015729096;5513.393526712059;5523.751431185607;5536.667799932017;5549.38956714761;5573.6098473106495;5170.45710200431;5184.688918664892;5202.479752024768;5238;5246.685198888079;4606.447226332862;4620.792064357112;4718.292256161603;4722.740249286322;4751.59611433032;5548.9722551386985;5584.218209450599;5598;5603.831885043455;5655.717214139277;5514.448555144453;5519.641223320471;5540.91688624679;5541.196526503554;5574.16387541872;5195.76619052136;5311.49540793624;5341.732913354394;5449.64577302474;5572.052751032254;5329.413764485981;5436.157395603688;5455.645383050089;5462.508374246337;5472.2338872557075;5489.725513724377;5493.835184944458;5511.476409741068;5514.5864060196445;5571.60998730085;4973.5523802857915;5152.098382782923;5224.817131400383;5237.921431178612;5275.841724748264;5227.764750586309;5256.553192978639;5372.086745253238;5389.434109418455;5395.055865223649;5234.450382709913;5270.472952704852;5279.736013199402;5286.180642000496;5314.97342513285;5138.254953031715;5147.897042059213;5189.351331083614;5227.3465816772905;5334.3865455473115;5225.399079105951;5247.501487358695;5262.815801446931;5269.815556455505;5271.920921186109 09:44:52 INFO - 2015-11-18 09:44:52,022 DEBUG : BROWSER_OUTPUT: |1;ext.html;519.888224031833;520.1391696741891;521.3613323678494;531.7739960516781;539.9298091248137;30043.849780751094;30867.69132308676;36647.450288245665;36960.075998099994;36988.07529811756;39392.409113863316;40086.39870401939;40130.7993460033;40481.59518404815;40603.79698101505;7714.575698336589;8379.664813407471;8527.147285271485;8529.445586036887;8541.658333666646;7885.448018638697;10039.146672532843;10231.386116833013;10268.486575671224;10379.84430233547;10037.197024238043;10059.849102263472;10069.899301007006;10101.393916365005;10209.081182693557;7914.841703165962;7990.720324788605;9957.551910164024;10123.696289111338;10261.230407719451;9836.852447213298;9955.651552195639;10006.249531285182;10007.949960250226;10017.799644007078;36933.81533092344;37072.814635926916;37075.62924370749;37153.25693486142;37927.43108853342;2662.4408874136457;2704.2698471412805;2865.398266364066;3153.416617925668;3300.092474569489;25559.361015974562;25687.48625027489;25691.229263122135;25963.945046797715;26266.343341416425;2111.8416118790997;2136.337735302046;2165.545235500531;2186.8797216153107;2226.2096955580696;262273;263665;264296;264667.6766616174;267052;48636.7568162164;48927.26609100866;56176;56634.150487742714;56671;62882.68558657177;63807;64075.35924640694;64101;64268;16041.759373609406;16134.838651613569;16288.104154271392;16294.592635184215;16332.918335408247;11963.102767292488;11980.341081240615;11980.64058078259;11996.940015299868;12009.579664711868;17640.20619072145;17748.55628609269;18023.819761802213;18056.63886722258;18088.547786305448;7255.818604534823;7637.770866874002;7649.464537482323;7671.769846904602;7690.577018263937;826.9545175015431;848.6987119572586;850.1031411860547;928.132196396358;1017.7048655889857;26430.471390572464;27460.17619471419;27981.160565183076;28001.57997630037;28022;933.9486328252011;973.1971123822874;1073.291627525845;1096.3860238266595;1122.966311010671;11110.444477776078;12701.428435720414;12905.35473226335;13089;13887.513937012358;286383;296251;296584;297859;299664;43561;43774;50131.24803127956;50257;50724;1255.8304628874985;1263.4314558448734;1265.4811527273773;1267.1700036476122;1270.6569226308845;25700.357491062125;25786.226413206885;26699.599506007038;26809.731902680724;26899.731002690507;43380;43527;43627.56372436235;43846.34230486609;43916.56083439253;245328;246577;248084;249506;251871;29136;29376;29553.85223073871;29784.702152979058;30199.849000754857;36963.63036369602;37011;37282;38059.61940380672;39610;31713.841430793622;32372;32821.507677385336;32853.507197391584;33095.17262068467;31933.520997184594;32674.673253267163;37292.25415491729;38612.6138738609;39891.80054099711;37059.25881482409;38379.040523987125;38600.613993859704;39030.21939561136;39090.4136437948;32678.673213267564;34965.77619783295;35580;36340;36814.8159259202;28986;29006.564901526915;29130.27174320659;29343.706562934953;29479 09:44:52 INFO - 2015-11-18 09:44:52,026 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.9935201295974;324.49757622209165;327.80495605114953;330.0659134648944;339.1047634245592;13866.584002479942;14320.570382888503;16060.357585696573;16439.91780041101;16779.1610419479;13735.656608584766;14329.498467553638;16619.252133653983;16643.33426662932;17226.655466890654;4982.352294201749;5113.258577506259;5131.974340128313;5153.974230128844;5166.17341225404;3840.4047372657283;4005.178938317638;4990.176620857555;5138.306328645641;5142.254373115896;5310.4424035476295;5486.259354987065;5492.340919089715;5496.615236933416;5568.610197286192;5371.113766228587;5448.564114870801;5508;5573.052581061229;5603.3836278009385;4782.258749893772;4796.544328288842;4802.087603355386;4805.279208118775;4839.395075615548;19748.70376944347;20629.17483300681;20662.896685516625;20695.06872190755;20830.062647180912;1836.9265229390808;1871.5227616957725;1896.6491199128207;2000.9599808003904;2027.4424533253325;12338.938305308506;12519.43662535188;12562.246265224116;12980;13189.208647481086;1485.1683057487733;1507.2991059157544;1526.9923650381788;1533.45562325374;1603.3907115296229;48979.265311020004;50537.74731126358;50777.492225078015;53330.466695332936;56634.150487742714;6182.690865456799;6191.380861913863;6242.28213755424;6246.375362463808;6347.079673447417;7156.499045066899;7168.892466613005;7170.533915295489;7191.89212161818;7243.167035790846;4854.732989685531;5043.041822053798;5147.948520514747;5293.523582877482;5343.278657381282;5481.068218402881;5648.774049038075;5656.2929633795775;5707.258056452634;5710.828675139753;2770.3074231442138;2786.8467234302307;2798.6921438641734;2808.8314701117997;2817.830930144157;978.6868202175378;979.8334283171736;1020.9438480883623;1024.4007255755466;1028.7068185567227;402.75230733099517;412.7667867654765;418.42675534517906;422.8308676529351;435.34263262473894;10399;10590.417527036087;10728.839067413996;10766.300190487593;11292.830607540893;400.5273776943177;401.5542747550217;407.68811858927944;408.5138684964882;408.579163461635;4765.928511072337;6066.787662431793;6079.179310793074;6165.84585385369;6174.598651087665;512498;516424;523392;525613;536225;66302.66848665726;67364.6631766838;67832.32167678358;67886;68282;473.7110362678763;474.07555267228355;477.8017122894099;478.4856279499552;481.3718097882297;10076.395416275047;10255.282130250811;10302.124319432633;10376.16990640762;10399.58401663925;32080;32170.19574510656;32321.838390807894;32576.83711581427;32782.34435311328;44325.77837110923;44343.77828110839;44736.10527789361;44933.326000110676;45854;6027.909581356195;6028.246469191351;6033.366496517978;6042.758289668364;6081.5742897996715;10963.177761667748;11124.276922000045;11148.721281967692;11362.715932101764;11421.885781142082;6960.860782784417;9292.58183381736;9567.61729530811;9606.855897161688;9635.421874687541;9030.367874249003;9108.453492790453;9223;9243.39917905334;9438.433693978383;9565.139137477661;9628.71113866585;9832.16426603718;9859.161971232239;9895.20838332946;5985.311689155628;5986.580939334205;6025.096235564701;6061.242344706911;6158.938410615837;9323.627054917999;9724.562394692397;9862.85205721929;9894.15899648538;9938.602455901972 09:44:52 INFO - 2015-11-18 09:44:52,027 DEBUG : BROWSER_OUTPUT: |3;mootools.html;782.9882551761721;1341.6847040945377;1372.931353432328;1594.6810637872425;1741;6579.539432239745;7053.400460960818;7250.746223882165;7287.453440991921;7295.927040729591;6940.201876784171;7156.85686286274;7157.463190260738;7261.673224704888;7263.1284245890565;2022.2416593777334;2047.610953918758;2049.7950204979534;2059.824914882237;2063.9886455636706;2041.9387418377473;2059.2586668799295;2065.2461851424273;2071.2439959414783;2071.3785864240667;2038.1541660210994;2045.5908818236337;2056.928007519737;2057.19769289977;2076.563921576471;1960.6666866632636;1966.822985931273;1975.1803001754254;1976.5750363671737;1977.7033444983297;1945.88324700517;1967.4687834284664;1990.731251281073;1994.9002549872448;2002.3792624286373;6318.304986451487;6492.707828147744;7163.1762347330205;7179.964100179465;7191.748288809867;4212.241796476664;4343.261645520269;4377.255866502702;4392.143532011259;4403.163398954189;2647.430802377498;2669.065826960568;2676.7055623881356;2682.2087484192016;2712.6744790625053;767.1446337333888;774.44240147094;779.8479296537178;780.8750599903988;800.5156880087521;9310.487923164223;9402.623895044258;9405.670801521914;9411.43531388119;9529.523523823782;3784.243151369737;3796.069962859062;3835;3835.4055121456217;3891.7081218908697;8273.627686754111;8294.170582941657;8303.792405189919;8318.500889946623;8398.622062007102;4356.455443069616;4360.084382279693;4382.23310920594;4387.802548885308;4426.11477704454;3971.801409929492;3993.780342081155;4006.258842114218;4008.5189777226337;4017.4375587417785;3284.7207987321344;3291.078498020558;3313.1551454378978;3343.2477692519474;3353.84907679155;1074.7420619051372;1076.8169411200115;1078.9730256743644;1086.5002099034375;1086.5219303506433;891.2869704236584;921.3964853021282;926.2589928057527;936.7283487788601;1207.4325067218392;6645.534812563171;6688.966555167193;6723.899141512881;6777.288384719632;6858.759943401957;388.510476799235;394.9506311711036;397.0451065188227;402.67986950374524;404.94128351388883;5104.3874735031295;5324.893502129936;5338.679679219259;5396.298481197419;5398.271233383443;7711.614419279013;8230.506169629842;8470.49177049379;8509.276711479593;8559.914400856036;8204.548749818818;8340.62467188978;8423.873641895376;8429.4942303462;8433.873491897626;6728.158980127484;6833.111695479556;6842;6855.725770969205;6868.313168683192;6484.286728459771;6491.870162596816;6504.804855854332;6524.869502610016;6525.445337146396;7250.709971601288;7570.507916985378;7574.053243344582;7587.203343648837;7592.962035189788;7511.32398084175;7700.499467534592;7713.807154821175;7723.884141737991;7729.420293478124;6363.3636636336;6401.8399540010005;6440.388163124496;6442.935570644234;6455.67721613908;6910.689018994258;6940.375366217065;6956.2695916930015;6958.095447591781;6961.61711105894;6356.364363563606;6448.871022579616;6497.090407342881;6573.80278591643;6597.868042639217;6176.505879529716;6304.7162877671535;6337.746490140527;6350.523710721806;6422.389872962061;6392.4246817786625;6413.422791948747;6439.549231553934;6457.4188323049275;6510.609363438209;5819.505342045804;5832.766689332379;5876.382979787061;5887.411258874078;5956.047032474783;5924.289085309618;5957.970210148921;5971.790987315597;5979;6022.819315420545 09:44:52 INFO - 2015-11-18 09:44:52,029 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.1532250024923;280.2726923633173;281.7661341086898;283.4472778082739;284.0951569251931;5411.512963833255;5520.585956053302;5688.971555142223;5714.914276285859;5772.942270577293;5573.944260557393;5603.691796951166;5622.100463925773;5645.15322701594;5698.430156984299;4140.875773726778;4154.086101057763;4168.874933751992;4211.326187809951;4245.830166793325;4105.178964207155;4157.958420415787;4163.167366526707;4181.644560212386;4217.85237516687;4126.988887722498;4216.451861258032;4223.345381465862;4231.153769246148;4263.424437700917;4200.85297014603;4216.852410165629;4222.0289333453475;4237.809298581556;4243.872683819491;3628.727845411605;3632.3280193164087;3665.4318580620047;3669.94495082574;3678.301122786662;5399.1091469907415;5438.972805135989;5457.426970168115;5485.396606373296;5531.1426728857095;4761.952380476186;4768.856934291976;4791.233402655594;4808.471068182497;4815.3017812417;5821.417858214187;5856.502197313233;5868.4424979626865;5886.146508756249;5923.141144534062;3841.8847434577006;3915.8629447969183;3916.8824935251987;3920.588338224474;3970.265500882346;5853.09277062056;6114.205153330083;6168.352323006065;6171.197744293213;6178.41305076017;4027.295223335963;4039.535453422894;4047.8988025299013;4074.2055299216368;4083.795810209537;4122.855700050483;4130.091379896478;4148.253314403436;4184.769837658958;4238.470191226097;4789.3294938708605;4794.113089078532;4794.736289504111;4846.491118432585;4855.514448555116;5834.726874169356;5854.238948936696;5927.288725352985;5949.434803693643;5961.791337303173;1449.5071675630336;1469.6032071340678;1471.0952764050032;1491.164947629331;1491.7165738509648;949.0367277213634;956.5982287439292;966.5022513405602;970.8543718442149;983.9114479696862;5729.427057294237;5758.683272419973;5766.077427611562;5785.4214578541805;5796.304443466811;6136.662483563447;6150.846228844314;6154.261488621394;6226.533010024266;6227.595206311576;5706.572007099484;5718.942810571924;5722.113072473773;5749.453801888814;5776.451237132465;3314.1548905029063;3368.4105281576117;3369.797812131231;3384.1708781348725;3431.022158684763;6171.907421388682;6229.470495007885;6234.314225435199;6238.500919926486;6269.467095296951;6125.111858780452;6215.409536094064;6228.377162283826;6239.78160764371;6293.433590976834;6106.297775755756;6165.475934545434;6183.196184496077;6185.350538193515;6260.68696565179;5919.970400147971;6040.6979651018155;6094.299155597163;6101.6644084574;6155.415235552616;5916.970415147896;5922.052471604695;5929.229200203946;5934.910976335272;5942.821715348547;6215.658138802229;6218.502519798315;6219.937800622117;6235.719392627252;6243.375662433902;3732.6080761519647;3760.266747984117;3761.1725420407465;3771.151490914522;3804.619538046173;6092.45167934888;6094.177286066324;6098.176746139215;6098.847528811815;6109.908351374822;5720.427957204246;5802.47777700009;5971.641701497924;5989.700514974146;5992.221011268507;5966.642001479925;5971.701414929323;5993.430624090704;6006.219191505076;6014.518838492822;5849;5872.882542349214;5873.295204575478;5908.852278693067;5910.852228694317;5813.854653633693;5926;5992.760289588367;6028.728707208274;6083.422074902877;5812;5813.3605303417435;5819.505342045804;5867.647941123546;5885.264341957255 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.6529083394553;727.323589062172;728.7959371376013;732.6995931668016;740.0859937976597;13038.804417933727;13287.601371958845;13292.734145317088;13409.731805363886;13466.057375983684;13605.863941360583;13678;13886.166829990208;13935.860641393583;13940.790888136686;671.1208317104608;836.1805430677924;851.8849955256054;859.7248880358288;861.1517655109712;678.3657280442777;835.3567752830317;847.1909326593088;853.7737499562621;860.3934226370425;840.4285086141422;855.9572021398936;872.677109469494;878.3544095090103;883.3816328569994;691.1567887177611;697.5291678117301;844.1431946574232;869.1699427047187;870;627.1032423634201;632.2318383164477;637.8756142552204;639.4660458517144;641.0480436551717;12776.936115319457;12982.221066736027;13002.86997130026;13055.281959492224;13097.41061652228;9085.772855678595;9121.49831759253;9176.632934682671;9625.422474651543;9733.756656083655;8491.702790402369;8540.145985401472;8571.957140214321;8604.612792424356;8641.395102342838;2646.338415396151;2736.370634753998;2778.7221277872254;2791.159672212565;2836.3334616365137;46084.53915460836;46392.53607463916;46397.536024639994;46870.062598748176;46953.29570056452;6355.968220158869;6387.489000879918;6424.453921416639;6573.112629794917;6644.435223006002;11672.124590655734;11682;11685.415729213506;11830.40847957616;11843.46704398304;5864.912026319608;5906.8818623627285;5914.172015917775;6014.36849130835;6098.298695649968;3521.436570148764;3577.44549594808;3589.3718599245026;3631.6005239423644;3706.221693444353;2346.7653234676736;2376.061455724979;2378.63131214662;2395.5927492326346;2397.196939025411;360.48810688821936;374.79573632370426;375.7144570126723;379.1790772976475;380.31353407099897;481.8434008947106;507.4823679846536;525.1807180797891;542.552394274717;545.0924211188327;6868.450523958071;6915.101036865276;6973.686184121727;7013.368796808311;7046.964765176142;398.3427344880912;484.94665586785425;560.4815545620285;568.6701713006446;569.0354848531699;3283.6387997320276;3517.525134106914;3538.398472259722;3607.098225443639;3607.85568577254;54315.45684543104;54680;55003.174952375746;55231.17153242705;56234;48303;48322;48349.75825120852;48398;49597.50402496001;47143.76428117906;47461;47543.52456475391;47561.524384756405;47607;6952.652367381509;7043.7182512700965;7227.49407541467;7251.383632391306;7615.5149745799035;33883.4917476243;34498.82750586231;34608.30783384368;34736.30527389388;35099.649003509636;47109.52890471051;47169.76415117903;47383.28925066058;47432.525674742814;48077.519224808704;6324.786324786288;6671.566348187353;6750.561213521106;7011.193712723102;7166;10509.2118091145;10571.418571978615;10701;11020.779584408107;11621.535138594361;9205.585748641193;9289.907100928904;9299.628014879328;9304.906950930404;9527.714168574954;8844.380893337404;8970.102989700978;9267.629294828132;9383.624655013722;9389.765255868659;7508.474406791473;8190.221928916743;8405.285550728257;8682.131786821268;9383.953080234829;8003.879941800994;8229.509335476825;8314.376421768271;8360.581970901309;8565.27195188416;7624.27569380908;7673.194314596887;7694.4229182810395;7833.608319583884;7949.1255961843 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1017 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: __startTimestamp1447868692017__endTimestamp 09:44:52 INFO - 2015-11-18 09:44:52,034 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5070.46 Median:5224.82 stddev:535.06 (10.2%) stddev-sans-first:511.39 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: Values: 2997.1 3009.7 3042.8 3145.6 3181.7 5091.2 5138.2 5145.4 5190.4 5204.3 5147.4 5151.4 5181.7 5195.7 5206.7 4650.6 4745.2 4745.7 4786.2 4799.6 4595.7 4633.5 4722.4 4728.9 4738.6 4755.9 4805.8 4834.2 4838.1 4884.1 4527.2 4792.4 4804.1 4836.3 4866.9 4532.3 4661.9 4662.3 4665.5 4691.3 5010.2 5113.5 5148.6 5159.9 5170.5 5219.5 5305.9 5494.0 5515.3 5539.6 5264.1 5352.8 5357.4 5374.6 5387.1 5007.6 5092.4 5110.9 5118.1 5157.3 5399.2 5527.3 5559.6 5629.6 5647.5 5261.6 5381.5 5387.9 5420.0 5430.9 5457.2 5516.1 5522.2 5530.2 5550.5 5180.6 5288.5 5314.5 5464.3 5496.3 5170.5 5288.3 5291.1 5340.7 5359.8 4068.5 4157.8 4199.7 4201.3 4232.3 3815.7 3833.6 3837.1 3843.9 3870.1 4887.1 5033.3 5042.3 5099.8 5199.7 5513.4 5523.8 5536.7 5549.4 5573.6 5170.5 5184.7 5202.5 5238.0 5246.7 4606.4 4620.8 4718.3 4722.7 4751.6 5549.0 5584.2 5598.0 5603.8 5655.7 5514.4 5519.6 5540.9 5541.2 5574.2 5195.8 5311.5 5341.7 5449.6 5572.1 5329.4 5436.2 5455.6 5462.5 5472.2 5489.7 5493.8 5511.5 5514.6 5571.6 4973.6 5152.1 5224.8 5237.9 5275.8 5227.8 5256.6 5372.1 5389.4 5395.1 5234.5 5270.5 5279.7 5286.2 5315.0 5138.3 5147.9 5189.4 5227.3 5334.4 5225.4 5247.5 5262.8 5269.8 5271.9 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,035 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43602.21 Median:30121.85 stddev:70408.87 (233.7%) stddev-sans-first:70532.08 09:44:52 INFO - 2015-11-18 09:44:52,036 DEBUG : BROWSER_OUTPUT: Values: 519.9 520.1 521.4 531.8 539.9 30043.8 30867.7 36647.5 36960.1 36988.1 39392.4 40086.4 40130.8 40481.6 40603.8 7714.6 8379.7 8527.1 8529.4 8541.7 7885.4 10039.1 10231.4 10268.5 10379.8 10037.2 10059.8 10069.9 10101.4 10209.1 7914.8 7990.7 9957.6 10123.7 10261.2 9836.9 9955.7 10006.2 10007.9 10017.8 36933.8 37072.8 37075.6 37153.3 37927.4 2662.4 2704.3 2865.4 3153.4 3300.1 25559.4 25687.5 25691.2 25963.9 26266.3 2111.8 2136.3 2165.5 2186.9 2226.2 262273.0 263665.0 264296.0 264667.7 267052.0 48636.8 48927.3 56176.0 56634.2 56671.0 62882.7 63807.0 64075.4 64101.0 64268.0 16041.8 16134.8 16288.1 16294.6 16332.9 11963.1 11980.3 11980.6 11996.9 12009.6 17640.2 17748.6 18023.8 18056.6 18088.5 7255.8 7637.8 7649.5 7671.8 7690.6 827.0 848.7 850.1 928.1 1017.7 26430.5 27460.2 27981.2 28001.6 28022.0 933.9 973.2 1073.3 1096.4 1123.0 11110.4 12701.4 12905.4 13089.0 13887.5 286383.0 296251.0 296584.0 297859.0 299664.0 43561.0 43774.0 50131.2 50257.0 50724.0 1255.8 1263.4 1265.5 1267.2 1270.7 25700.4 25786.2 26699.6 26809.7 26899.7 43380.0 43527.0 43627.6 43846.3 43916.6 245328.0 246577.0 248084.0 249506.0 251871.0 29136.0 29376.0 29553.9 29784.7 30199.8 36963.6 37011.0 37282.0 38059.6 39610.0 31713.8 32372.0 32821.5 32853.5 33095.2 31933.5 32674.7 37292.3 38612.6 39891.8 37059.3 38379.0 38600.6 39030.2 39090.4 32678.7 34965.8 35580.0 36340.0 36814.8 28986.0 29006.6 29130.3 29343.7 29479.0 09:44:52 INFO - 2015-11-18 09:44:52,036 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,036 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25849.62 Median:4847.06 stddev:85528.51 (1764.5%) stddev-sans-first:85746.96 09:44:52 INFO - 2015-11-18 09:44:52,036 DEBUG : BROWSER_OUTPUT: Values: 324.0 324.5 327.8 330.1 339.1 13866.6 14320.6 16060.4 16439.9 16779.2 13735.7 14329.5 16619.3 16643.3 17226.7 4982.4 5113.3 5132.0 5154.0 5166.2 3840.4 4005.2 4990.2 5138.3 5142.3 5310.4 5486.3 5492.3 5496.6 5568.6 5371.1 5448.6 5508.0 5573.1 5603.4 4782.3 4796.5 4802.1 4805.3 4839.4 19748.7 20629.2 20662.9 20695.1 20830.1 1836.9 1871.5 1896.6 2001.0 2027.4 12338.9 12519.4 12562.2 12980.0 13189.2 1485.2 1507.3 1527.0 1533.5 1603.4 48979.3 50537.7 50777.5 53330.5 56634.2 6182.7 6191.4 6242.3 6246.4 6347.1 7156.5 7168.9 7170.5 7191.9 7243.2 4854.7 5043.0 5147.9 5293.5 5343.3 5481.1 5648.8 5656.3 5707.3 5710.8 2770.3 2786.8 2798.7 2808.8 2817.8 978.7 979.8 1020.9 1024.4 1028.7 402.8 412.8 418.4 422.8 435.3 10399.0 10590.4 10728.8 10766.3 11292.8 400.5 401.6 407.7 408.5 408.6 4765.9 6066.8 6079.2 6165.8 6174.6 512498.0 516424.0 523392.0 525613.0 536225.0 66302.7 67364.7 67832.3 67886.0 68282.0 473.7 474.1 477.8 478.5 481.4 10076.4 10255.3 10302.1 10376.2 10399.6 32080.0 32170.2 32321.8 32576.8 32782.3 44325.8 44343.8 44736.1 44933.3 45854.0 6027.9 6028.2 6033.4 6042.8 6081.6 10963.2 11124.3 11148.7 11362.7 11421.9 6960.9 9292.6 9567.6 9606.9 9635.4 9030.4 9108.5 9223.0 9243.4 9438.4 9565.1 9628.7 9832.2 9859.2 9895.2 5985.3 5986.6 6025.1 6061.2 6158.9 9323.6 9724.6 9862.9 9894.2 9938.6 09:44:52 INFO - 2015-11-18 09:44:52,036 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,037 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4939.53 Median:6359.86 stddev:2593.66 (40.8%) stddev-sans-first:2582.11 09:44:52 INFO - 2015-11-18 09:44:52,038 DEBUG : BROWSER_OUTPUT: Values: 783.0 1341.7 1372.9 1594.7 1741.0 6579.5 7053.4 7250.7 7287.5 7295.9 6940.2 7156.9 7157.5 7261.7 7263.1 2022.2 2047.6 2049.8 2059.8 2064.0 2041.9 2059.3 2065.2 2071.2 2071.4 2038.2 2045.6 2056.9 2057.2 2076.6 1960.7 1966.8 1975.2 1976.6 1977.7 1945.9 1967.5 1990.7 1994.9 2002.4 6318.3 6492.7 7163.2 7180.0 7191.7 4212.2 4343.3 4377.3 4392.1 4403.2 2647.4 2669.1 2676.7 2682.2 2712.7 767.1 774.4 779.8 780.9 800.5 9310.5 9402.6 9405.7 9411.4 9529.5 3784.2 3796.1 3835.0 3835.4 3891.7 8273.6 8294.2 8303.8 8318.5 8398.6 4356.5 4360.1 4382.2 4387.8 4426.1 3971.8 3993.8 4006.3 4008.5 4017.4 3284.7 3291.1 3313.2 3343.2 3353.8 1074.7 1076.8 1079.0 1086.5 1086.5 891.3 921.4 926.3 936.7 1207.4 6645.5 6689.0 6723.9 6777.3 6858.8 388.5 395.0 397.0 402.7 404.9 5104.4 5324.9 5338.7 5396.3 5398.3 7711.6 8230.5 8470.5 8509.3 8559.9 8204.5 8340.6 8423.9 8429.5 8433.9 6728.2 6833.1 6842.0 6855.7 6868.3 6484.3 6491.9 6504.8 6524.9 6525.4 7250.7 7570.5 7574.1 7587.2 7593.0 7511.3 7700.5 7713.8 7723.9 7729.4 6363.4 6401.8 6440.4 6442.9 6455.7 6910.7 6940.4 6956.3 6958.1 6961.6 6356.4 6448.9 6497.1 6573.8 6597.9 6176.5 6304.7 6337.7 6350.5 6422.4 6392.4 6413.4 6439.5 6457.4 6510.6 5819.5 5832.8 5876.4 5887.4 5956.0 5924.3 5958.0 5971.8 5979.0 6022.8 09:44:52 INFO - 2015-11-18 09:44:52,038 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,038 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4911.94 Median:5762.38 stddev:1511.65 (26.2%) stddev-sans-first:1475.24 09:44:52 INFO - 2015-11-18 09:44:52,040 DEBUG : BROWSER_OUTPUT: Values: 273.2 280.3 281.8 283.4 284.1 5411.5 5520.6 5689.0 5714.9 5772.9 5573.9 5603.7 5622.1 5645.2 5698.4 4140.9 4154.1 4168.9 4211.3 4245.8 4105.2 4158.0 4163.2 4181.6 4217.9 4127.0 4216.5 4223.3 4231.2 4263.4 4200.9 4216.9 4222.0 4237.8 4243.9 3628.7 3632.3 3665.4 3669.9 3678.3 5399.1 5439.0 5457.4 5485.4 5531.1 4762.0 4768.9 4791.2 4808.5 4815.3 5821.4 5856.5 5868.4 5886.1 5923.1 3841.9 3915.9 3916.9 3920.6 3970.3 5853.1 6114.2 6168.4 6171.2 6178.4 4027.3 4039.5 4047.9 4074.2 4083.8 4122.9 4130.1 4148.3 4184.8 4238.5 4789.3 4794.1 4794.7 4846.5 4855.5 5834.7 5854.2 5927.3 5949.4 5961.8 1449.5 1469.6 1471.1 1491.2 1491.7 949.0 956.6 966.5 970.9 983.9 5729.4 5758.7 5766.1 5785.4 5796.3 6136.7 6150.8 6154.3 6226.5 6227.6 5706.6 5718.9 5722.1 5749.5 5776.5 3314.2 3368.4 3369.8 3384.2 3431.0 6171.9 6229.5 6234.3 6238.5 6269.5 6125.1 6215.4 6228.4 6239.8 6293.4 6106.3 6165.5 6183.2 6185.4 6260.7 5920.0 6040.7 6094.3 6101.7 6155.4 5917.0 5922.1 5929.2 5934.9 5942.8 6215.7 6218.5 6219.9 6235.7 6243.4 3732.6 3760.3 3761.2 3771.2 3804.6 6092.5 6094.2 6098.2 6098.8 6109.9 5720.4 5802.5 5971.6 5989.7 5992.2 5966.6 5971.7 5993.4 6006.2 6014.5 5849.0 5872.9 5873.3 5908.9 5910.9 5813.9 5926.0 5992.8 6028.7 6083.4 5812.0 5813.4 5819.5 5867.6 5885.3 09:44:52 INFO - 2015-11-18 09:44:52,040 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,040 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12639.73 Median:5885.90 stddev:15945.26 (270.9%) stddev-sans-first:15964.85 09:44:52 INFO - 2015-11-18 09:44:52,041 DEBUG : BROWSER_OUTPUT: Values: 715.7 727.3 728.8 732.7 740.1 13038.8 13287.6 13292.7 13409.7 13466.1 13605.9 13678.0 13886.2 13935.9 13940.8 671.1 836.2 851.9 859.7 861.2 678.4 835.4 847.2 853.8 860.4 840.4 856.0 872.7 878.4 883.4 691.2 697.5 844.1 869.2 870.0 627.1 632.2 637.9 639.5 641.0 12776.9 12982.2 13002.9 13055.3 13097.4 9085.8 9121.5 9176.6 9625.4 9733.8 8491.7 8540.1 8572.0 8604.6 8641.4 2646.3 2736.4 2778.7 2791.2 2836.3 46084.5 46392.5 46397.5 46870.1 46953.3 6356.0 6387.5 6424.5 6573.1 6644.4 11672.1 11682.0 11685.4 11830.4 11843.5 5864.9 5906.9 5914.2 6014.4 6098.3 3521.4 3577.4 3589.4 3631.6 3706.2 2346.8 2376.1 2378.6 2395.6 2397.2 360.5 374.8 375.7 379.2 380.3 481.8 507.5 525.2 542.6 545.1 6868.5 6915.1 6973.7 7013.4 7047.0 398.3 484.9 560.5 568.7 569.0 3283.6 3517.5 3538.4 3607.1 3607.9 54315.5 54680.0 55003.2 55231.2 56234.0 48303.0 48322.0 48349.8 48398.0 49597.5 47143.8 47461.0 47543.5 47561.5 47607.0 6952.7 7043.7 7227.5 7251.4 7615.5 33883.5 34498.8 34608.3 34736.3 35099.6 47109.5 47169.8 47383.3 47432.5 48077.5 6324.8 6671.6 6750.6 7011.2 7166.0 10509.2 10571.4 10701.0 11020.8 11621.5 9205.6 9289.9 9299.6 9304.9 9527.7 8844.4 8970.1 9267.6 9383.6 9389.8 7508.5 8190.2 8405.3 8682.1 9384.0 8003.9 8229.5 8314.4 8360.6 8565.3 7624.3 7673.2 7694.4 7833.6 7949.1 09:44:52 INFO - 2015-11-18 09:44:52,041 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:52 INFO - 2015-11-18 09:44:52,041 DEBUG : BROWSER_OUTPUT: 09:44:52 INFO - 2015-11-18 09:44:52,692 INFO : Browser exited with error code: 0 09:44:52 INFO - 2015-11-18 09:44:52,721 INFO : Completed test dromaeo_css (00:18:33) 09:44:52 INFO - 2015-11-18 09:44:52,721 INFO : Starting test kraken 09:44:52 INFO - 2015-11-18 09:44:52,721 DEBUG : operating with platform_type : mac_ 09:44:52 INFO - 2015-11-18 09:44:52,721 INFO : Initialising browser for kraken test... 09:44:52 INFO - 2015-11-18 09:44:52,735 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpDLiDrW/profile http://localhost:56049/getInfo.html 09:44:55 INFO - 2015-11-18 09:44:55,056 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:55 INFO - 2015-11-18 09:44:55,056 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:55 INFO - 2015-11-18 09:44:55,057 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:44:55 INFO - 2015-11-18 09:44:55,057 DEBUG : BROWSER_OUTPUT: __metrics 09:44:55 INFO - 2015-11-18 09:44:55,073 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:55 INFO - 2015-11-18 09:44:55,746 INFO : Browser initialized. 09:44:55 INFO - 2015-11-18 09:44:55,746 INFO : Running cycle 1/1 for kraken test... 09:44:55 INFO - 2015-11-18 09:44:55,746 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpDLiDrW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:07 INFO - 2015-11-18 09:45:07,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 200003584 09:45:07 INFO - 2015-11-18 09:45:07,670 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-18 09:45:10,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:10 INFO - 2015-11-18 09:45:10,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 264478720 09:45:10 INFO - 2015-11-18 09:45:10,836 DEBUG : BROWSER_OUTPUT: 09:45:13 INFO - 2015-11-18 09:45:13,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-dft) 09:45:14 INFO - 2015-11-18 09:45:14,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 279441408 09:45:14 INFO - 2015-11-18 09:45:14,203 DEBUG : BROWSER_OUTPUT: 09:45:17 INFO - 2015-11-18 09:45:17,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-fft) 09:45:17 INFO - 2015-11-18 09:45:17,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 265629696 09:45:17 INFO - 2015-11-18 09:45:17,796 DEBUG : BROWSER_OUTPUT: 09:45:19 INFO - 2015-11-18 09:45:19,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-oscillator) 09:45:20 INFO - 2015-11-18 09:45:20,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 265175040 09:45:20 INFO - 2015-11-18 09:45:20,491 DEBUG : BROWSER_OUTPUT: 09:45:22 INFO - 2015-11-18 09:45:22,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:23 INFO - 2015-11-18 09:45:23,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 266952704 09:45:23 INFO - 2015-11-18 09:45:23,413 DEBUG : BROWSER_OUTPUT: 09:45:26 INFO - 2015-11-18 09:45:26,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56049/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:27 INFO - 2015-11-18 09:45:27,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 266792960 09:45:27 INFO - 2015-11-18 09:45:27,273 DEBUG : BROWSER_OUTPUT: 09:45:30 INFO - 2015-11-18 09:45:30,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56049/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:31 INFO - 2015-11-18 09:45:31,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 265416704 09:45:31 INFO - 2015-11-18 09:45:31,184 DEBUG : BROWSER_OUTPUT: 09:45:34 INFO - 2015-11-18 09:45:34,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56049/tests/kraken/driver.html?testName=json-parse-financial) 09:45:34 INFO - 2015-11-18 09:45:34,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 267034624 09:45:34 INFO - 2015-11-18 09:45:34,841 DEBUG : BROWSER_OUTPUT: 09:45:36 INFO - 2015-11-18 09:45:36,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:37 INFO - 2015-11-18 09:45:37,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 300408832 09:45:37 INFO - 2015-11-18 09:45:37,077 DEBUG : BROWSER_OUTPUT: 09:45:38 INFO - 2015-11-18 09:45:38,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:39 INFO - 2015-11-18 09:45:39,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 302022656 09:45:39 INFO - 2015-11-18 09:45:39,585 DEBUG : BROWSER_OUTPUT: 09:45:41 INFO - 2015-11-18 09:45:41,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:42 INFO - 2015-11-18 09:45:42,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 307609600 09:45:42 INFO - 2015-11-18 09:45:42,356 DEBUG : BROWSER_OUTPUT: 09:45:45 INFO - 2015-11-18 09:45:45,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:45 INFO - 2015-11-18 09:45:45,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 310353920 09:45:45 INFO - 2015-11-18 09:45:45,667 DEBUG : BROWSER_OUTPUT: 09:45:48 INFO - 2015-11-18 09:45:48,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:48 INFO - 2015-11-18 09:45:48,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 310075392 09:45:48 INFO - 2015-11-18 09:45:48,950 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-18 09:45:50,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56049/tests/kraken/driver.html?testName=ai-astar) 09:45:51 INFO - 2015-11-18 09:45:51,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 368119808 09:45:51 INFO - 2015-11-18 09:45:51,013 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,013 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:45:51 INFO - 2015-11-18 09:45:51,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:45:51 INFO - 2015-11-18 09:45:51,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:45:51 INFO - 2015-11-18 09:45:51,013 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:45:51 INFO - 2015-11-18 09:45:51,013 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;112;108;108;112;111;101;111;96;111 09:45:51 INFO - 2015-11-18 09:45:51,014 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;132;169;163;135;170;144;177;161;143 09:45:51 INFO - 2015-11-18 09:45:51,014 DEBUG : BROWSER_OUTPUT: |2;audio-dft;167;174;181;180;173;174;177;181;177;174 09:45:51 INFO - 2015-11-18 09:45:51,014 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;85;84;131;76;77;78;78;125;74 09:45:51 INFO - 2015-11-18 09:45:51,014 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;105;148;97;101;99;138;112;108;147 09:45:51 INFO - 2015-11-18 09:45:51,014 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;129;131;136;127;130;130;135;130;136;135 09:45:51 INFO - 2015-11-18 09:45:51,014 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;135;140;140;137;134;140;140;136;135;140 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;107;113;113;114;113;113;112;113;113;112 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;64;64;66;67;68;78;63;65 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;66;69;74;75;74;72;74;69 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;91;92;92;92;92;91;92;96;96 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;145;137;141;144;132;142;132;135;133 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;145;162;163;165;155;157;160;161;149 09:45:51 INFO - 2015-11-18 09:45:51,015 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;73;73;74;78;79;77;78;78;77 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,894 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: __startTimestamp1447868751008__endTimestamp 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:45:51 INFO - 2015-11-18 09:45:51,016 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:45:51 INFO - 2015-11-18 09:45:51,017 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,017 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:111.00 stddev:5.29 (4.8%) stddev-sans-first:5.61 09:45:51 INFO - 2015-11-18 09:45:51,017 DEBUG : BROWSER_OUTPUT: Values: 108.0 112.0 108.0 108.0 112.0 111.0 101.0 111.0 96.0 111.0 09:45:51 INFO - 2015-11-18 09:45:51,017 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,017 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:155.70 Median:163.00 stddev:15.84 (9.7%) stddev-sans-first:16.58 09:45:51 INFO - 2015-11-18 09:45:51,017 DEBUG : BROWSER_OUTPUT: Values: 163.0 132.0 169.0 163.0 135.0 170.0 144.0 177.0 161.0 143.0 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:175.80 Median:177.00 stddev:4.34 (2.5%) stddev-sans-first:3.23 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: Values: 167.0 174.0 181.0 180.0 173.0 174.0 177.0 181.0 177.0 174.0 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.10 Median:78.00 stddev:20.86 (26.7%) stddev-sans-first:22.01 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 131.0 76.0 77.0 78.0 78.0 125.0 74.0 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,018 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.50 Median:142.50 stddev:20.54 (14.4%) stddev-sans-first:21.01 09:45:51 INFO - 2015-11-18 09:45:51,019 DEBUG : BROWSER_OUTPUT: Values: 100.0 105.0 148.0 97.0 101.0 99.0 138.0 112.0 108.0 147.0 09:45:51 INFO - 2015-11-18 09:45:51,019 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,019 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:131.90 Median:133.00 stddev:3.28 (2.5%) stddev-sans-first:3.31 09:45:51 INFO - 2015-11-18 09:45:51,019 DEBUG : BROWSER_OUTPUT: Values: 129.0 131.0 136.0 127.0 130.0 130.0 135.0 130.0 136.0 135.0 09:45:51 INFO - 2015-11-18 09:45:51,019 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,019 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:137.70 Median:140.00 stddev:2.54 (1.8%) stddev-sans-first:2.50 09:45:51 INFO - 2015-11-18 09:45:51,020 DEBUG : BROWSER_OUTPUT: Values: 135.0 140.0 140.0 137.0 134.0 140.0 140.0 136.0 135.0 140.0 09:45:51 INFO - 2015-11-18 09:45:51,020 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,020 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:112.30 Median:113.00 stddev:1.95 (1.7%) stddev-sans-first:0.60 09:45:51 INFO - 2015-11-18 09:45:51,020 DEBUG : BROWSER_OUTPUT: Values: 107.0 113.0 113.0 114.0 113.0 113.0 112.0 113.0 113.0 112.0 09:45:51 INFO - 2015-11-18 09:45:51,020 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,020 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.50 stddev:4.80 (7.3%) stddev-sans-first:4.77 09:45:51 INFO - 2015-11-18 09:45:51,021 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 64.0 64.0 66.0 67.0 68.0 78.0 63.0 65.0 09:45:51 INFO - 2015-11-18 09:45:51,021 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,022 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:73.00 stddev:3.60 (4.9%) stddev-sans-first:3.57 09:45:51 INFO - 2015-11-18 09:45:51,022 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 69.0 74.0 75.0 74.0 72.0 74.0 69.0 09:45:51 INFO - 2015-11-18 09:45:51,022 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:92.00 stddev:3.84 (4.2%) stddev-sans-first:1.94 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: Values: 82.0 91.0 92.0 92.0 92.0 92.0 91.0 92.0 96.0 96.0 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:139.00 stddev:5.66 (4.1%) stddev-sans-first:5.21 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: Values: 129.0 145.0 137.0 141.0 144.0 132.0 142.0 132.0 135.0 133.0 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:160.50 stddev:6.48 (4.0%) stddev-sans-first:6.71 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: Values: 153.0 145.0 162.0 163.0 165.0 155.0 157.0 160.0 161.0 149.0 09:45:51 INFO - 2015-11-18 09:45:51,023 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,024 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:77.50 stddev:2.98 (3.8%) stddev-sans-first:2.35 09:45:51 INFO - 2015-11-18 09:45:51,024 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 73.0 74.0 78.0 79.0 77.0 78.0 78.0 77.0 09:45:51 INFO - 2015-11-18 09:45:51,024 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:45:51 INFO - 2015-11-18 09:45:51,024 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-18 09:45:51,677 INFO : Browser exited with error code: 0 09:45:51 INFO - 2015-11-18 09:45:51,730 INFO : Completed test kraken (00:00:59) 09:45:51 INFO - 2015-11-18 09:45:51,730 INFO : Starting test v8_7 09:45:51 INFO - 2015-11-18 09:45:51,730 DEBUG : operating with platform_type : mac_ 09:45:51 INFO - 2015-11-18 09:45:51,730 INFO : Initialising browser for v8_7 test... 09:45:51 INFO - 2015-11-18 09:45:51,745 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpx06o6v/profile http://localhost:56049/getInfo.html 09:45:54 INFO - 2015-11-18 09:45:54,016 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:54 INFO - 2015-11-18 09:45:54,016 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:54 INFO - 2015-11-18 09:45:54,016 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:45:54 INFO - 2015-11-18 09:45:54,017 DEBUG : BROWSER_OUTPUT: __metrics 09:45:54 INFO - 2015-11-18 09:45:54,024 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:54 INFO - 2015-11-18 09:45:54,740 INFO : Browser initialized. 09:45:54 INFO - 2015-11-18 09:45:54,741 INFO : Running cycle 1/1 for v8_7 test... 09:45:54 INFO - 2015-11-18 09:45:54,741 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpx06o6v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:46:06 INFO - 2015-11-18 09:46:06,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 200310784 09:46:06 INFO - 2015-11-18 09:46:06,711 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56049/tests/v8_7/run.html (next: http://localhost:56049/tests/v8_7/run.html) 09:46:28 INFO - 2015-11-18 09:46:28,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 541167616 09:46:28 INFO - 2015-11-18 09:46:28,417 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,417 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |0;Richards;167.8697330871244 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.67822736030828 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |2;Encrypt;353.2320734722713 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6185.185185185185 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1131.2217194570135 09:46:28 INFO - 2015-11-18 09:46:28,418 DEBUG : BROWSER_OUTPUT: |5;Earley;745.7121551081283 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: |6;Boyer;13400 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: |7;RegExp;31060.60606060606 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: |8;Splay;696.8641114982578 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6236.024844720497 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1447868788411__endTimestamp 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:46:28 INFO - 2015-11-18 09:46:28,419 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: Values: 167.9 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.68 Median:192.68 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: Values: 192.7 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,420 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:353.23 Median:353.23 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: Values: 353.2 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6185.19 Median:6185.19 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: Values: 6185.2 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1131.22 Median:1131.22 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: Values: 1131.2 09:46:28 INFO - 2015-11-18 09:46:28,421 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:745.71 Median:745.71 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: Values: 745.7 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13400.00 Median:13400.00 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: Values: 13400.0 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31060.61 Median:31060.61 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,422 DEBUG : BROWSER_OUTPUT: Values: 31060.6 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:696.86 Median:696.86 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: Values: 696.9 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6236.02 Median:6236.02 stddev:0.00 (0.0%) 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: Values: 6236.0 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:46:28 INFO - 2015-11-18 09:46:28,423 DEBUG : BROWSER_OUTPUT: 09:46:29 INFO - 2015-11-18 09:46:29,057 INFO : Browser exited with error code: 0 09:46:29 INFO - 2015-11-18 09:46:29,078 INFO : Completed test v8_7 (00:00:37) 09:46:29 INFO - 2015-11-18 09:46:29,532 INFO : Completed test suite (00:20:10) 09:46:29 INFO - 2015-11-18 09:46:29,532 DEBUG : Working with test: dromaeo_css 09:46:29 INFO - 2015-11-18 09:46:29,532 DEBUG : Generating results file: dromaeo_css 09:46:29 INFO - 2015-11-18 09:46:29,533 DEBUG : Working with test: kraken 09:46:29 INFO - 2015-11-18 09:46:29,533 DEBUG : Generating results file: kraken 09:46:29 INFO - 2015-11-18 09:46:29,533 INFO : javascript benchmark 09:46:29 INFO - 2015-11-18 09:46:29,533 DEBUG : Working with test: v8_7 09:46:29 INFO - 2015-11-18 09:46:29,533 DEBUG : Generating results file: v8_7 09:46:29 INFO - 2015-11-18 09:46:29,533 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:29 INFO - 2015-11-18 09:46:29,583 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:46:29 INFO - 2015-11-18 09:46:29,583 DEBUG : process_Request line: dromaeo_css 6171.63 graph.html#tests=[[72,52,55]] 09:46:29 INFO - 2015-11-18 09:46:29,583 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:29 INFO - 2015-11-18 09:46:29,609 DEBUG : process_Request line: kraken 1623.50 graph.html#tests=[[232,52,55]] 09:46:29 INFO - 2015-11-18 09:46:29,609 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:29 INFO - 2015-11-18 09:46:29,650 DEBUG : process_Request line: v8_7 18903.55 graph.html#tests=[[230,52,55]] 09:46:29 INFO - 2015-11-18 09:46:29,651 INFO : javascript benchmark 09:46:29 INFO - 2015-11-18 09:46:29,653 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [323.9935201295974, 324.49757622209165, 327.80495605114953, 330.0659134648944, 339.1047634245592, 13866.584002479942, 14320.570382888503, 16060.357585696573, 16439.91780041101, 16779.1610419479, 13735.656608584766, 14329.498467553638, 16619.252133653983, 16643.33426662932, 17226.655466890654, 4982.352294201749, 5113.258577506259, 5131.974340128313, 5153.974230128844, 5166.17341225404, 3840.4047372657283, 4005.178938317638, 4990.176620857555, 5138.306328645641, 5142.254373115896, 5310.4424035476295, 5486.259354987065, 5492.340919089715, 5496.615236933416, 5568.610197286192, 5371.113766228587, 5448.564114870801, 5508.0, 5573.052581061229, 5603.3836278009385, 4782.258749893772, 4796.544328288842, 4802.087603355386, 4805.279208118775, 4839.395075615548, 19748.70376944347, 20629.17483300681, 20662.896685516625, 20695.06872190755, 20830.062647180912, 1836.9265229390808, 1871.5227616957725, 1896.6491199128207, 2000.9599808003904, 2027.4424533253325, 12338.938305308506, 12519.43662535188, 12562.246265224116, 12980.0, 13189.208647481086, 1485.1683057487733, 1507.2991059157544, 1526.9923650381788, 1533.45562325374, 1603.3907115296229, 48979.265311020004, 50537.74731126358, 50777.492225078015, 53330.466695332936, 56634.150487742714, 6182.690865456799, 6191.380861913863, 6242.28213755424, 6246.375362463808, 6347.079673447417, 7156.499045066899, 7168.892466613005, 7170.533915295489, 7191.89212161818, 7243.167035790846, 4854.732989685531, 5043.041822053798, 5147.948520514747, 5293.523582877482, 5343.278657381282, 5481.068218402881, 5648.774049038075, 5656.2929633795775, 5707.258056452634, 5710.828675139753, 2770.3074231442138, 2786.8467234302307, 2798.6921438641734, 2808.8314701117997, 2817.830930144157, 978.6868202175378, 979.8334283171736, 1020.9438480883623, 1024.4007255755466, 1028.7068185567227, 402.75230733099517, 412.7667867654765, 418.42675534517906, 422.8308676529351, 435.34263262473894, 10399.0, 10590.417527036087, 10728.839067413996, 10766.300190487593, 11292.830607540893, 400.5273776943177, 401.5542747550217, 407.68811858927944, 408.5138684964882, 408.579163461635, 4765.928511072337, 6066.787662431793, 6079.179310793074, 6165.84585385369, 6174.598651087665, 512498.0, 516424.0, 523392.0, 525613.0, 536225.0, 66302.66848665726, 67364.6631766838, 67832.32167678358, 67886.0, 68282.0, 473.7110362678763, 474.07555267228355, 477.8017122894099, 478.4856279499552, 481.3718097882297, 10076.395416275047, 10255.282130250811, 10302.124319432633, 10376.16990640762, 10399.58401663925, 32080.0, 32170.19574510656, 32321.838390807894, 32576.83711581427, 32782.34435311328, 44325.77837110923, 44343.77828110839, 44736.10527789361, 44933.326000110676, 45854.0, 6027.909581356195, 6028.246469191351, 6033.366496517978, 6042.758289668364, 6081.5742897996715, 10963.177761667748, 11124.276922000045, 11148.721281967692, 11362.715932101764, 11421.885781142082, 6960.860782784417, 9292.58183381736, 9567.61729530811, 9606.855897161688, 9635.421874687541, 9030.367874249003, 9108.453492790453, 9223.0, 9243.39917905334, 9438.433693978383, 9565.139137477661, 9628.71113866585, 9832.16426603718, 9859.161971232239, 9895.20838332946, 5985.311689155628, 5986.580939334205, 6025.096235564701, 6061.242344706911, 6158.938410615837, 9323.627054917999, 9724.562394692397, 9862.85205721929, 9894.15899648538, 9938.602455901972], "dojo.html": [2997.145813443169, 3009.7140771626714, 3042.7565794736424, 3145.6382516010653, 3181.6659250778666, 5091.236314552819, 5138.177891537355, 5145.3568303962, 5190.403103643082, 5204.319964865347, 5147.356580427447, 5151.4333423323405, 5181.715005674687, 5195.662281951671, 5206.739663016843, 4650.581447669709, 4745.193317136095, 4745.73898435585, 4786.162421576228, 4799.616030717534, 4595.747233902151, 4633.536646335357, 4722.386089808338, 4728.929066064012, 4738.6446016548725, 4755.857324280277, 4805.831795887145, 4834.178189707741, 4838.104950584153, 4884.096442158212, 4527.207738645757, 4792.424909010923, 4804.111239420683, 4836.322914791932, 4866.853994380174, 4532.27483602622, 4661.906761864778, 4662.254039353721, 4665.533446655308, 4691.3432119503295, 5010.223415370623, 5113.488651134894, 5148.588112950955, 5159.922601160985, 5170.482951704837, 5219.4780521947505, 5305.867353316159, 5493.972530137364, 5515.255440515519, 5539.612227144102, 5264.078786212397, 5352.839414817562, 5357.357117145929, 5374.6237763356585, 5387.138057910715, 5007.574356179765, 5092.363454568179, 5110.897782044375, 5118.129917913963, 5157.329547158845, 5399.244105825188, 5527.309086364205, 5559.555235581225, 5629.577781666391, 5647.463490968352, 5261.552768014685, 5381.542568881689, 5387.9461205388225, 5420.0, 5430.945690543123, 5457.154141108134, 5516.117421212667, 5522.22688823565, 5530.225768392428, 5550.47270509301, 5180.559652429586, 5288.497592728685, 5314.4951229633125, 5464.316960379952, 5496.340439147328, 5170.482951704799, 5288.286081379041, 5291.100512912814, 5340.706261155596, 5359.812406565751, 4068.4710987571425, 4157.833686652561, 4199.748015119103, 4201.34879093741, 4232.280512312914, 3815.6947444204397, 3833.5783063862955, 3837.0982819037504, 3843.9231215375535, 3870.1098747288283, 4887.144749668793, 5033.3205017322925, 5042.3444952156715, 5099.821506247264, 5199.714015729096, 5513.393526712059, 5523.751431185607, 5536.667799932017, 5549.38956714761, 5573.6098473106495, 5170.45710200431, 5184.688918664892, 5202.479752024768, 5238.0, 5246.685198888079, 4606.447226332862, 4620.792064357112, 4718.292256161603, 4722.740249286322, 4751.59611433032, 5548.9722551386985, 5584.218209450599, 5598.0, 5603.831885043455, 5655.717214139277, 5514.448555144453, 5519.641223320471, 5540.91688624679, 5541.196526503554, 5574.16387541872, 5195.76619052136, 5311.49540793624, 5341.732913354394, 5449.64577302474, 5572.052751032254, 5329.413764485981, 5436.157395603688, 5455.645383050089, 5462.508374246337, 5472.2338872557075, 5489.725513724377, 5493.835184944458, 5511.476409741068, 5514.5864060196445, 5571.60998730085, 4973.5523802857915, 5152.098382782923, 5224.817131400383, 5237.921431178612, 5275.841724748264, 5227.764750586309, 5256.553192978639, 5372.086745253238, 5389.434109418455, 5395.055865223649, 5234.450382709913, 5270.472952704852, 5279.736013199402, 5286.180642000496, 5314.97342513285, 5138.254953031715, 5147.897042059213, 5189.351331083614, 5227.3465816772905, 5334.3865455473115, 5225.399079105951, 5247.501487358695, 5262.815801446931, 5269.815556455505, 5271.920921186109], "mootools.html": [782.9882551761721, 1341.6847040945377, 1372.931353432328, 1594.6810637872425, 1741.0, 6579.539432239745, 7053.400460960818, 7250.746223882165, 7287.453440991921, 7295.927040729591, 6940.201876784171, 7156.85686286274, 7157.463190260738, 7261.673224704888, 7263.1284245890565, 2022.2416593777334, 2047.610953918758, 2049.7950204979534, 2059.824914882237, 2063.9886455636706, 2041.9387418377473, 2059.2586668799295, 2065.2461851424273, 2071.2439959414783, 2071.3785864240667, 2038.1541660210994, 2045.5908818236337, 2056.928007519737, 2057.19769289977, 2076.563921576471, 1960.6666866632636, 1966.822985931273, 1975.1803001754254, 1976.5750363671737, 1977.7033444983297, 1945.88324700517, 1967.4687834284664, 1990.731251281073, 1994.9002549872448, 2002.3792624286373, 6318.304986451487, 6492.707828147744, 7163.1762347330205, 7179.964100179465, 7191.748288809867, 4212.241796476664, 4343.261645520269, 4377.255866502702, 4392.143532011259, 4403.163398954189, 2647.430802377498, 2669.065826960568, 2676.7055623881356, 2682.2087484192016, 2712.6744790625053, 767.1446337333888, 774.44240147094, 779.8479296537178, 780.8750599903988, 800.5156880087521, 9310.487923164223, 9402.623895044258, 9405.670801521914, 9411.43531388119, 9529.523523823782, 3784.243151369737, 3796.069962859062, 3835.0, 3835.4055121456217, 3891.7081218908697, 8273.627686754111, 8294.170582941657, 8303.792405189919, 8318.500889946623, 8398.622062007102, 4356.455443069616, 4360.084382279693, 4382.23310920594, 4387.802548885308, 4426.11477704454, 3971.801409929492, 3993.780342081155, 4006.258842114218, 4008.5189777226337, 4017.4375587417785, 3284.7207987321344, 3291.078498020558, 3313.1551454378978, 3343.2477692519474, 3353.84907679155, 1074.7420619051372, 1076.8169411200115, 1078.9730256743644, 1086.5002099034375, 1086.5219303506433, 891.2869704236584, 921.3964853021282, 926.2589928057527, 936.7283487788601, 1207.4325067218392, 6645.534812563171, 6688.966555167193, 6723.899141512881, 6777.288384719632, 6858.759943401957, 388.510476799235, 394.9506311711036, 397.0451065188227, 402.67986950374524, 404.94128351388883, 5104.3874735031295, 5324.893502129936, 5338.679679219259, 5396.298481197419, 5398.271233383443, 7711.614419279013, 8230.506169629842, 8470.49177049379, 8509.276711479593, 8559.914400856036, 8204.548749818818, 8340.62467188978, 8423.873641895376, 8429.4942303462, 8433.873491897626, 6728.158980127484, 6833.111695479556, 6842.0, 6855.725770969205, 6868.313168683192, 6484.286728459771, 6491.870162596816, 6504.804855854332, 6524.869502610016, 6525.445337146396, 7250.709971601288, 7570.507916985378, 7574.053243344582, 7587.203343648837, 7592.962035189788, 7511.32398084175, 7700.499467534592, 7713.807154821175, 7723.884141737991, 7729.420293478124, 6363.3636636336, 6401.8399540010005, 6440.388163124496, 6442.935570644234, 6455.67721613908, 6910.689018994258, 6940.375366217065, 6956.2695916930015, 6958.095447591781, 6961.61711105894, 6356.364363563606, 6448.871022579616, 6497.090407342881, 6573.80278591643, 6597.868042639217, 6176.505879529716, 6304.7162877671535, 6337.746490140527, 6350.523710721806, 6422.389872962061, 6392.4246817786625, 6413.422791948747, 6439.549231553934, 6457.4188323049275, 6510.609363438209, 5819.505342045804, 5832.766689332379, 5876.382979787061, 5887.411258874078, 5956.047032474783, 5924.289085309618, 5957.970210148921, 5971.790987315597, 5979.0, 6022.819315420545], "ext.html": [519.888224031833, 520.1391696741891, 521.3613323678494, 531.7739960516781, 539.9298091248137, 30043.849780751094, 30867.69132308676, 36647.450288245665, 36960.075998099994, 36988.07529811756, 39392.409113863316, 40086.39870401939, 40130.7993460033, 40481.59518404815, 40603.79698101505, 7714.575698336589, 8379.664813407471, 8527.147285271485, 8529.445586036887, 8541.658333666646, 7885.448018638697, 10039.146672532843, 10231.386116833013, 10268.486575671224, 10379.84430233547, 10037.197024238043, 10059.849102263472, 10069.899301007006, 10101.393916365005, 10209.081182693557, 7914.841703165962, 7990.720324788605, 9957.551910164024, 10123.696289111338, 10261.230407719451, 9836.852447213298, 9955.651552195639, 10006.249531285182, 10007.949960250226, 10017.799644007078, 36933.81533092344, 37072.814635926916, 37075.62924370749, 37153.25693486142, 37927.43108853342, 2662.4408874136457, 2704.2698471412805, 2865.398266364066, 3153.416617925668, 3300.092474569489, 25559.361015974562, 25687.48625027489, 25691.229263122135, 25963.945046797715, 26266.343341416425, 2111.8416118790997, 2136.337735302046, 2165.545235500531, 2186.8797216153107, 2226.2096955580696, 262273.0, 263665.0, 264296.0, 264667.6766616174, 267052.0, 48636.7568162164, 48927.26609100866, 56176.0, 56634.150487742714, 56671.0, 62882.68558657177, 63807.0, 64075.35924640694, 64101.0, 64268.0, 16041.759373609406, 16134.838651613569, 16288.104154271392, 16294.592635184215, 16332.918335408247, 11963.102767292488, 11980.341081240615, 11980.64058078259, 11996.940015299868, 12009.579664711868, 17640.20619072145, 17748.55628609269, 18023.819761802213, 18056.63886722258, 18088.547786305448, 7255.818604534823, 7637.770866874002, 7649.464537482323, 7671.769846904602, 7690.577018263937, 826.9545175015431, 848.6987119572586, 850.1031411860547, 928.132196396358, 1017.7048655889857, 26430.471390572464, 27460.17619471419, 27981.160565183076, 28001.57997630037, 28022.0, 933.9486328252011, 973.1971123822874, 1073.291627525845, 1096.3860238266595, 1122.966311010671, 11110.444477776078, 12701.428435720414, 12905.35473226335, 13089.0, 13887.513937012358, 286383.0, 296251.0, 296584.0, 297859.0, 299664.0, 43561.0, 43774.0, 50131.24803127956, 50257.0, 50724.0, 1255.8304628874985, 1263.4314558448734, 1265.4811527273773, 1267.1700036476122, 1270.6569226308845, 25700.357491062125, 25786.226413206885, 26699.599506007038, 26809.731902680724, 26899.731002690507, 43380.0, 43527.0, 43627.56372436235, 43846.34230486609, 43916.56083439253, 245328.0, 246577.0, 248084.0, 249506.0, 251871.0, 29136.0, 29376.0, 29553.85223073871, 29784.702152979058, 30199.849000754857, 36963.63036369602, 37011.0, 37282.0, 38059.61940380672, 39610.0, 31713.841430793622, 32372.0, 32821.507677385336, 32853.507197391584, 33095.17262068467, 31933.520997184594, 32674.673253267163, 37292.25415491729, 38612.6138738609, 39891.80054099711, 37059.25881482409, 38379.040523987125, 38600.613993859704, 39030.21939561136, 39090.4136437948, 32678.673213267564, 34965.77619783295, 35580.0, 36340.0, 36814.8159259202, 28986.0, 29006.564901526915, 29130.27174320659, 29343.706562934953, 29479.0], "prototype.html": [273.1532250024923, 280.2726923633173, 281.7661341086898, 283.4472778082739, 284.0951569251931, 5411.512963833255, 5520.585956053302, 5688.971555142223, 5714.914276285859, 5772.942270577293, 5573.944260557393, 5603.691796951166, 5622.100463925773, 5645.15322701594, 5698.430156984299, 4140.875773726778, 4154.086101057763, 4168.874933751992, 4211.326187809951, 4245.830166793325, 4105.178964207155, 4157.958420415787, 4163.167366526707, 4181.644560212386, 4217.85237516687, 4126.988887722498, 4216.451861258032, 4223.345381465862, 4231.153769246148, 4263.424437700917, 4200.85297014603, 4216.852410165629, 4222.0289333453475, 4237.809298581556, 4243.872683819491, 3628.727845411605, 3632.3280193164087, 3665.4318580620047, 3669.94495082574, 3678.301122786662, 5399.1091469907415, 5438.972805135989, 5457.426970168115, 5485.396606373296, 5531.1426728857095, 4761.952380476186, 4768.856934291976, 4791.233402655594, 4808.471068182497, 4815.3017812417, 5821.417858214187, 5856.502197313233, 5868.4424979626865, 5886.146508756249, 5923.141144534062, 3841.8847434577006, 3915.8629447969183, 3916.8824935251987, 3920.588338224474, 3970.265500882346, 5853.09277062056, 6114.205153330083, 6168.352323006065, 6171.197744293213, 6178.41305076017, 4027.295223335963, 4039.535453422894, 4047.8988025299013, 4074.2055299216368, 4083.795810209537, 4122.855700050483, 4130.091379896478, 4148.253314403436, 4184.769837658958, 4238.470191226097, 4789.3294938708605, 4794.113089078532, 4794.736289504111, 4846.491118432585, 4855.514448555116, 5834.726874169356, 5854.238948936696, 5927.288725352985, 5949.434803693643, 5961.791337303173, 1449.5071675630336, 1469.6032071340678, 1471.0952764050032, 1491.164947629331, 1491.7165738509648, 949.0367277213634, 956.5982287439292, 966.5022513405602, 970.8543718442149, 983.9114479696862, 5729.427057294237, 5758.683272419973, 5766.077427611562, 5785.4214578541805, 5796.304443466811, 6136.662483563447, 6150.846228844314, 6154.261488621394, 6226.533010024266, 6227.595206311576, 5706.572007099484, 5718.942810571924, 5722.113072473773, 5749.453801888814, 5776.451237132465, 3314.1548905029063, 3368.4105281576117, 3369.797812131231, 3384.1708781348725, 3431.022158684763, 6171.907421388682, 6229.470495007885, 6234.314225435199, 6238.500919926486, 6269.467095296951, 6125.111858780452, 6215.409536094064, 6228.377162283826, 6239.78160764371, 6293.433590976834, 6106.297775755756, 6165.475934545434, 6183.196184496077, 6185.350538193515, 6260.68696565179, 5919.970400147971, 6040.6979651018155, 6094.299155597163, 6101.6644084574, 6155.415235552616, 5916.970415147896, 5922.052471604695, 5929.229200203946, 5934.910976335272, 5942.821715348547, 6215.658138802229, 6218.502519798315, 6219.937800622117, 6235.719392627252, 6243.375662433902, 3732.6080761519647, 3760.266747984117, 3761.1725420407465, 3771.151490914522, 3804.619538046173, 6092.45167934888, 6094.177286066324, 6098.176746139215, 6098.847528811815, 6109.908351374822, 5720.427957204246, 5802.47777700009, 5971.641701497924, 5989.700514974146, 5992.221011268507, 5966.642001479925, 5971.701414929323, 5993.430624090704, 6006.219191505076, 6014.518838492822, 5849.0, 5872.882542349214, 5873.295204575478, 5908.852278693067, 5910.852228694317, 5813.854653633693, 5926.0, 5992.760289588367, 6028.728707208274, 6083.422074902877, 5812.0, 5813.3605303417435, 5819.505342045804, 5867.647941123546, 5885.264341957255], "yui.html": [715.6529083394553, 727.323589062172, 728.7959371376013, 732.6995931668016, 740.0859937976597, 13038.804417933727, 13287.601371958845, 13292.734145317088, 13409.731805363886, 13466.057375983684, 13605.863941360583, 13678.0, 13886.166829990208, 13935.860641393583, 13940.790888136686, 671.1208317104608, 836.1805430677924, 851.8849955256054, 859.7248880358288, 861.1517655109712, 678.3657280442777, 835.3567752830317, 847.1909326593088, 853.7737499562621, 860.3934226370425, 840.4285086141422, 855.9572021398936, 872.677109469494, 878.3544095090103, 883.3816328569994, 691.1567887177611, 697.5291678117301, 844.1431946574232, 869.1699427047187, 870.0, 627.1032423634201, 632.2318383164477, 637.8756142552204, 639.4660458517144, 641.0480436551717, 12776.936115319457, 12982.221066736027, 13002.86997130026, 13055.281959492224, 13097.41061652228, 9085.772855678595, 9121.49831759253, 9176.632934682671, 9625.422474651543, 9733.756656083655, 8491.702790402369, 8540.145985401472, 8571.957140214321, 8604.612792424356, 8641.395102342838, 2646.338415396151, 2736.370634753998, 2778.7221277872254, 2791.159672212565, 2836.3334616365137, 46084.53915460836, 46392.53607463916, 46397.536024639994, 46870.062598748176, 46953.29570056452, 6355.968220158869, 6387.489000879918, 6424.453921416639, 6573.112629794917, 6644.435223006002, 11672.124590655734, 11682.0, 11685.415729213506, 11830.40847957616, 11843.46704398304, 5864.912026319608, 5906.8818623627285, 5914.172015917775, 6014.36849130835, 6098.298695649968, 3521.436570148764, 3577.44549594808, 3589.3718599245026, 3631.6005239423644, 3706.221693444353, 2346.7653234676736, 2376.061455724979, 2378.63131214662, 2395.5927492326346, 2397.196939025411, 360.48810688821936, 374.79573632370426, 375.7144570126723, 379.1790772976475, 380.31353407099897, 481.8434008947106, 507.4823679846536, 525.1807180797891, 542.552394274717, 545.0924211188327, 6868.450523958071, 6915.101036865276, 6973.686184121727, 7013.368796808311, 7046.964765176142, 398.3427344880912, 484.94665586785425, 560.4815545620285, 568.6701713006446, 569.0354848531699, 3283.6387997320276, 3517.525134106914, 3538.398472259722, 3607.098225443639, 3607.85568577254, 54315.45684543104, 54680.0, 55003.174952375746, 55231.17153242705, 56234.0, 48303.0, 48322.0, 48349.75825120852, 48398.0, 49597.50402496001, 47143.76428117906, 47461.0, 47543.52456475391, 47561.524384756405, 47607.0, 6952.652367381509, 7043.7182512700965, 7227.49407541467, 7251.383632391306, 7615.5149745799035, 33883.4917476243, 34498.82750586231, 34608.30783384368, 34736.30527389388, 35099.649003509636, 47109.52890471051, 47169.76415117903, 47383.28925066058, 47432.525674742814, 48077.519224808704, 6324.786324786288, 6671.566348187353, 6750.561213521106, 7011.193712723102, 7166.0, 10509.2118091145, 10571.418571978615, 10701.0, 11020.779584408107, 11621.535138594361, 9205.585748641193, 9289.907100928904, 9299.628014879328, 9304.906950930404, 9527.714168574954, 8844.380893337404, 8970.102989700978, 9267.629294828132, 9383.624655013722, 9389.765255868659, 7508.474406791473, 8190.221928916743, 8405.285550728257, 8682.131786821268, 9383.953080234829, 8003.879941800994, 8229.509335476825, 8314.376421768271, 8360.581970901309, 8565.27195188416, 7624.27569380908, 7673.194314596887, 7694.4229182810395, 7833.608319583884, 7949.1255961843]}, "summary": {"suite": 6171.631162854083, "subtests": {"jquery.html": {"filtered": 6617.80051138666, "value": 6617.80051138666}, "dojo.html": {"filtered": 5037.474385067185, "value": 5037.474385067185}, "mootools.html": {"filtered": 3943.745139671214, "value": 3943.745139671214}, "ext.html": {"filtered": 17604.25231809496, "value": 17604.25231809496}, "prototype.html": {"filtered": 4407.712574061484, "value": 4407.712574061484}, "yui.html": {"filtered": 5416.147067467034, "value": 5416.147067467034}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0097"}, "testrun": {"date": 1447867578, "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": "20151118034229", "branch": "Mozilla-Aurora", "revision": "2a339d6b372566faedde8fdc11d7a47d8266be2a"}}, {"talos_counters": {}, "results": {"audio-dft": [167.0, 174.0, 181.0, 180.0, 173.0, 174.0, 177.0, 181.0, 177.0, 174.0], "ai-astar": [108.0, 112.0, 108.0, 108.0, 112.0, 111.0, 101.0, 111.0, 96.0, 111.0], "imaging-gaussian-blur": [129.0, 131.0, 136.0, 127.0, 130.0, 130.0, 135.0, 130.0, 136.0, 135.0], "audio-beat-detection": [163.0, 132.0, 169.0, 163.0, 135.0, 170.0, 144.0, 177.0, 161.0, 143.0], "json-stringify-tinderbox": [67.0, 66.0, 66.0, 69.0, 74.0, 75.0, 74.0, 72.0, 74.0, 69.0], "stanford-crypto-pbkdf2": [153.0, 145.0, 162.0, 163.0, 165.0, 155.0, 157.0, 160.0, 161.0, 149.0], "json-parse-financial": [61.0, 62.0, 64.0, 64.0, 66.0, 67.0, 68.0, 78.0, 63.0, 65.0], "stanford-crypto-sha256-iterative": [70.0, 73.0, 73.0, 74.0, 78.0, 79.0, 77.0, 78.0, 78.0, 77.0], "audio-fft": [83.0, 85.0, 84.0, 131.0, 76.0, 77.0, 78.0, 78.0, 125.0, 74.0], "imaging-darkroom": [135.0, 140.0, 140.0, 137.0, 134.0, 140.0, 140.0, 136.0, 135.0, 140.0], "stanford-crypto-ccm": [129.0, 145.0, 137.0, 141.0, 144.0, 132.0, 142.0, 132.0, 135.0, 133.0], "audio-oscillator": [100.0, 105.0, 148.0, 97.0, 101.0, 99.0, 138.0, 112.0, 108.0, 147.0], "stanford-crypto-aes": [82.0, 91.0, 92.0, 92.0, 92.0, 92.0, 91.0, 92.0, 96.0, 96.0], "imaging-desaturate": [107.0, 113.0, 113.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0]}, "summary": {"suite": 1623.4999999999998, "subtests": {"audio-fft": {"filtered": 89.1, "value": 89.1}, "stanford-crypto-pbkdf2": {"filtered": 157.0, "value": 157.0}, "audio-beat-detection": {"filtered": 155.7, "value": 155.7}, "stanford-crypto-ccm": {"filtered": 137.0, "value": 137.0}, "imaging-darkroom": {"filtered": 137.7, "value": 137.7}, "json-parse-financial": {"filtered": 65.8, "value": 65.8}, "audio-oscillator": {"filtered": 115.5, "value": 115.5}, "ai-astar": {"filtered": 107.8, "value": 107.8}, "audio-dft": {"filtered": 175.8, "value": 175.8}, "stanford-crypto-sha256-iterative": {"filtered": 75.7, "value": 75.7}, "json-stringify-tinderbox": {"filtered": 70.6, "value": 70.6}, "imaging-gaussian-blur": {"filtered": 131.9, "value": 131.9}, "stanford-crypto-aes": {"filtered": 91.6, "value": 91.6}, "imaging-desaturate": {"filtered": 112.3, "value": 112.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0097"}, "testrun": {"date": 1447867578, "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": "20151118034229", "branch": "Mozilla-Aurora", "revision": "2a339d6b372566faedde8fdc11d7a47d8266be2a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.67822736030828], "Encrypt": [353.2320734722713], "NavierStokes": [6236.024844720497], "Decrypt": [6185.185185185185], "Splay": [696.8641114982578], "Richards": [167.8697330871244], "RegExp": [31060.60606060606], "Earley": [745.7121551081283], "Boyer": [13400.0], "RayTrace": [1131.2217194570135]}, "summary": {"suite": 18903.553631367948, "subtests": {"DeltaBlue": {"filtered": 343.1524200000001, "value": 343.1524200000001}, "Encrypt": {"filtered": 753.5584110000002, "value": 753.5584110000002}, "NavierStokes": {"filtered": 237.9721115537849, "value": 237.9721115537849}, "Decrypt": {"filtered": 43.03525149700596, "value": 43.03525149700596}, "Splay": {"filtered": 116.93958500000001, "value": 116.93958500000001}, "RegExp": {"filtered": 29.329273170731714, "value": 29.329273170731714}, "Richards": {"filtered": 210.29401399999998, "value": 210.29401399999998}, "Earley": {"filtered": 893.7268829999998, "value": 893.7268829999998}, "Boyer": {"filtered": 49.73604477611944, "value": 49.73604477611944}, "RayTrace": {"filtered": 654.1502760000003, "value": 654.1502760000003}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0097"}, "testrun": {"date": 1447867578, "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": "20151118034229", "branch": "Mozilla-Aurora", "revision": "2a339d6b372566faedde8fdc11d7a47d8266be2a"}}] 09:46:29 INFO - RETURN: dromaeo_css: 6171.63 09:46:29 INFO - RETURN: kraken: 1623.50 09:46:29 INFO - RETURN: v8_7: 18903.55 09:46:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18903.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1623.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6171.63"}}} 09:46:29 INFO - Return code: 0 09:46:29 INFO - # TBPL SUCCESS # 09:46:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:29 INFO - 2015-11-18 09:46:29.737 screenresolution[1942:19443] starting screenresolution argv=screenresolution get 09:46:29 INFO - 2015-11-18 09:46:29.740 screenresolution[1942:19443] Display 0: 1600x1200x32@60 09:46:29 INFO - 2015-11-18 09:46:29.746 screenresolution[1943:19446] starting screenresolution argv=screenresolution list 09:46:29 INFO - Available Modes on Display 0 09:46:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:29 INFO - Intel HD Graphics 3000: 09:46:29 INFO - Chipset Model: Intel HD Graphics 3000 09:46:29 INFO - Type: GPU 09:46:29 INFO - Bus: Built-In 09:46:29 INFO - VRAM (Total): 512 MB 09:46:29 INFO - VRAM (Dynamic, Max): 10 09:46:29 INFO - Vendor: Intel (0x8086) 09:46:29 INFO - Device ID: 0x0116 09:46:29 INFO - Revision ID: 0x0009 09:46:29 INFO - Displays: 09:46:29 INFO - Display: 09:46:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:29 INFO - Display Serial Number: 1600x1200 60 09:46:29 INFO - Main Display: Yes 09:46:29 INFO - Mirror: Off 09:46:29 INFO - Online: Yes 09:46:29 INFO - Rotation: Supported 09:46:29 INFO - Return code: 0 09:46:29 INFO - Running post-action listener: _resource_record_post_action 09:46:29 INFO - Running post-run listener: _resource_record_post_run 09:46:31 INFO - Total resource usage - Wall time: 1251s; CPU: 30.0%; Read bytes: 163840; Write bytes: 682744832; Read time: 395; Write time: 63189 09:46:31 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 332288512; Write bytes: 335114240; Read time: 33313; Write time: 6887 09:46:31 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 163840; Write bytes: 337366016; Read time: 395; Write time: 55790 09:46:31 INFO - Running post-run listener: _upload_blobber_files 09:46:31 INFO - Blob upload gear active. 09:46:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:46:31 INFO - Copying logs to upload dir... 09:46:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1305.511592 ========= master_lag: 6.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-18 09:46:37.801991) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:46:37.807575) ========= 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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010047 build_url: 'https://queue.taskcluster.net/v1/task/rOXJq5N_Qd2lsO1WfG1TzA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.43 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:46:38.244962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:46:38.245281) ========= 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.uFoAT16VNe/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.TU9noDMosJ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005047 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:46:38.393138) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2015-11-18 09:46:38.393498) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2015-11-18 09:46:45.008898) ========= ========= Total master_lag: 12.96 =========