builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0050 starttime: 1448921027.61 results: success (0) buildid: 20151130131332 builduid: ff27d36c60314837bb0ec3a68e969e6a revision: 27a9ba2d01e9f0b987f1debb45e782d84a896d37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:47.607600) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:47.608265) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:47.608863) ========= 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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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.005710 basedir: '/builds/slave/test' ========= master_lag: 0.50 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.112948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.113270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.162117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.162417) ========= 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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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.033185 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.340354) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.340617) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.341082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.341352) ========= 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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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-30 14:03:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-30 14:03:48 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228520 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.600870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.601276) ========= 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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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.114216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:48.742812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-30 14:03:48.743138) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 27a9ba2d01e9f0b987f1debb45e782d84a896d37 --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 27a9ba2d01e9f0b987f1debb45e782d84a896d37 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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-30 14:03:48,833 truncating revision to first 12 chars 2015-11-30 14:03:48,834 Setting DEBUG logging. 2015-11-30 14:03:48,834 attempt 1/10 2015-11-30 14:03:48,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/27a9ba2d01e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-30 14:03:49,110 unpacking tar archive at: mozilla-aurora-27a9ba2d01e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532718 ========= master_lag: 2.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-30 14:03:52.202408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:52.202901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:52.303741) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:52.304056) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 14:03:52.305012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 49 secs) (at 2015-11-30 14:03:52.305299) ========= /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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:03:53 INFO - MultiFileLogger online at 20151130 14:03:53 in /builds/slave/test 14:03:53 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 14:03:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:03:53 INFO - {'append_to_log': False, 14:03:53 INFO - 'base_work_dir': '/builds/slave/test', 14:03:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:03:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:03:53 INFO - 'branch': 'Mozilla-Aurora', 14:03:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:03:53 INFO - 'config_files': ('talos/mac_config.py',), 14:03:53 INFO - 'default_actions': ('clobber', 14:03:53 INFO - 'read-buildbot-config', 14:03:53 INFO - 'download-and-extract', 14:03:53 INFO - 'populate-webroot', 14:03:53 INFO - 'create-virtualenv', 14:03:53 INFO - 'install', 14:03:53 INFO - 'run-tests'), 14:03:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:03:53 INFO - 'download_minidump_stackwalk': True, 14:03:53 INFO - 'download_symbols': 'ondemand', 14:03:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:03:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:03:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:03:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:03:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:03:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:03:53 INFO - 'installer_path': 'installer.exe', 14:03:53 INFO - 'log_level': 'info', 14:03:53 INFO - 'log_name': 'talos', 14:03:53 INFO - 'log_to_console': True, 14:03:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:03:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:03:53 INFO - 'opt_config_files': (), 14:03:53 INFO - 'pip_index': False, 14:03:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:03:53 INFO - 'cmd': ('bash', 14:03:53 INFO - '-c', 14:03:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:03:53 INFO - 'enabled': True, 14:03:53 INFO - 'halt_on_failure': False, 14:03:53 INFO - 'name': 'check_screen_resolution'},), 14:03:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:03:53 INFO - 'cmd': ('bash', 14:03:53 INFO - '-c', 14:03:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:03:53 INFO - 'enabled': True, 14:03:53 INFO - 'halt_on_failure': False, 14:03:53 INFO - 'name': 'check_screen_resolution'},), 14:03:53 INFO - 'run_cmd_checks_enabled': True, 14:03:53 INFO - 'sps_profile': False, 14:03:53 INFO - 'sps_profile_interval': 0, 14:03:53 INFO - 'suite': 'dromaeojs', 14:03:53 INFO - 'system_bits': '64', 14:03:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:03:53 INFO - 'title': 't-yosemite-r5-0050', 14:03:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:03:53 INFO - 'use_talos_json': True, 14:03:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:03:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:03:53 INFO - 'work_dir': 'build'} 14:03:53 INFO - ##### 14:03:53 INFO - ##### Running clobber step. 14:03:53 INFO - ##### 14:03:53 INFO - Running pre-action listener: _resource_record_pre_action 14:03:53 INFO - Running main action method: clobber 14:03:53 INFO - rmtree: /builds/slave/test/build 14:03:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:03:57 INFO - Running post-action listener: _resource_record_post_action 14:03:57 INFO - ##### 14:03:57 INFO - ##### Running read-buildbot-config step. 14:03:57 INFO - ##### 14:03:57 INFO - Running pre-action listener: _resource_record_pre_action 14:03:57 INFO - Running main action method: read_buildbot_config 14:03:57 INFO - Using buildbot properties: 14:03:57 INFO - { 14:03:57 INFO - "properties": { 14:03:57 INFO - "buildnumber": 282, 14:03:57 INFO - "product": "firefox", 14:03:57 INFO - "script_repo_revision": "production", 14:03:57 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 14:03:57 INFO - "repository": "", 14:03:57 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 14:03:57 INFO - "buildid": "20151130131332", 14:03:57 INFO - "slavename": "t-yosemite-r5-0050", 14:03:57 INFO - "pgo_build": "False", 14:03:57 INFO - "basedir": "/builds/slave/test", 14:03:57 INFO - "project": "", 14:03:57 INFO - "platform": "yosemite", 14:03:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:03:57 INFO - "slavebuilddir": "test", 14:03:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:03:57 INFO - "branch": "mozilla-aurora", 14:03:57 INFO - "repo_path": "releases/mozilla-aurora", 14:03:57 INFO - "stage_platform": "macosx64", 14:03:57 INFO - "builduid": "ff27d36c60314837bb0ec3a68e969e6a", 14:03:57 INFO - "revision": "27a9ba2d01e9f0b987f1debb45e782d84a896d37" 14:03:57 INFO - }, 14:03:57 INFO - "sourcestamp": { 14:03:57 INFO - "repository": "", 14:03:57 INFO - "hasPatch": false, 14:03:57 INFO - "project": "", 14:03:57 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:03:57 INFO - "changes": [ 14:03:57 INFO - { 14:03:57 INFO - "category": null, 14:03:57 INFO - "files": [ 14:03:57 INFO - { 14:03:57 INFO - "url": null, 14:03:57 INFO - "name": "https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 14:03:57 INFO - } 14:03:57 INFO - ], 14:03:57 INFO - "repository": "", 14:03:57 INFO - "rev": "27a9ba2d01e9f0b987f1debb45e782d84a896d37", 14:03:57 INFO - "who": "bgrinstead@mozilla.com", 14:03:57 INFO - "when": 1448920961, 14:03:57 INFO - "number": 6722833, 14:03:57 INFO - "comments": "Bug 1222617 - Filter out service worker messages that happened before a page load. r=bkelly, a=ritu", 14:03:57 INFO - "project": "", 14:03:57 INFO - "at": "Mon 30 Nov 2015 14:02:41", 14:03:57 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:03:57 INFO - "revlink": "", 14:03:57 INFO - "properties": [ 14:03:57 INFO - [ 14:03:57 INFO - "buildid", 14:03:57 INFO - "20151130131332", 14:03:57 INFO - "Change" 14:03:57 INFO - ], 14:03:57 INFO - [ 14:03:57 INFO - "builduid", 14:03:57 INFO - "ff27d36c60314837bb0ec3a68e969e6a", 14:03:57 INFO - "Change" 14:03:57 INFO - ], 14:03:57 INFO - [ 14:03:57 INFO - "pgo_build", 14:03:57 INFO - "False", 14:03:57 INFO - "Change" 14:03:57 INFO - ] 14:03:57 INFO - ], 14:03:57 INFO - "revision": "27a9ba2d01e9f0b987f1debb45e782d84a896d37" 14:03:57 INFO - } 14:03:57 INFO - ], 14:03:57 INFO - "revision": "27a9ba2d01e9f0b987f1debb45e782d84a896d37" 14:03:57 INFO - } 14:03:57 INFO - } 14:03:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 14:03:57 INFO - Running post-action listener: _resource_record_post_action 14:03:57 INFO - ##### 14:03:57 INFO - ##### Running download-and-extract step. 14:03:57 INFO - ##### 14:03:57 INFO - Running pre-action listener: _resource_record_pre_action 14:03:57 INFO - Running main action method: download_and_extract 14:03:57 INFO - mkdir: /builds/slave/test/build/tests 14:03:57 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')]} 14:03:57 INFO - https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:03:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json 14:03:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json 14:03:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:04:27 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json: timed out 14:04:27 INFO - retry: attempt #1 caught exception: timed out 14:04:27 INFO - retry: Failed, sleeping 30 seconds before retrying 14:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 14:05:00 INFO - Downloaded 1149 bytes. 14:05:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:05:00 INFO - Using the following test package requirements: 14:05:00 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:05:00 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 14:05:00 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'jsshell-mac.zip'], 14:05:00 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 14:05:00 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:05:00 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 14:05:00 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 14:05:00 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 14:05:00 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:05:00 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:05:00 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 14:05:00 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:05:00 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')]} 14:05:00 INFO - https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:02 INFO - Downloaded 17490140 bytes. 14:05:02 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 14:05:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:05:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:05:07 INFO - Return code: 0 14:05:07 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 14:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:07 INFO - https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:08 INFO - Downloaded 17490140 bytes. 14:05:08 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 14:05:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:05:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:05:14 INFO - Return code: 0 14:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:14 INFO - https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:05:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:05:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:05:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:15 INFO - Downloaded 11131307 bytes. 14:05:15 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 14:05:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:05:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:05:16 INFO - Return code: 0 14:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:16 INFO - https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 14:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:20 INFO - Downloaded 107829019 bytes. 14:05:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:05:20 INFO - mkdir: /builds/slave/test/properties 14:05:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:20 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:20 INFO - Contents: 14:05:20 INFO - build_url:https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:05:20 INFO - Running post-action listener: _resource_record_post_action 14:05:20 INFO - Running post-action listener: set_extra_try_arguments 14:05:20 INFO - ##### 14:05:20 INFO - ##### Running populate-webroot step. 14:05:20 INFO - ##### 14:05:20 INFO - Running pre-action listener: _resource_record_pre_action 14:05:20 INFO - Running main action method: populate_webroot 14:05:20 INFO - Guessing talos json url... 14:05:20 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')]} 14:05:20 INFO - https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 14:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/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 14:05:21 INFO - Downloaded 107 bytes. 14:05:21 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:05:21 INFO - Contents: 14:05:21 INFO - 20151130131332 14:05:21 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/27a9ba2d01e9f0b987f1debb45e782d84a896d37 14:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:21 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/27a9ba2d01/testing/talos/talos.json 14:05:21 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/27a9ba2d01/testing/talos/talos.json to /builds/slave/test/build/talos.json 14:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/27a9ba2d01/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 14:05:22 INFO - Downloaded 4264 bytes. 14:05:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:05:22 INFO - '../fennec_ids.txt'], 14:05:22 INFO - 'tests': ['tcheck2']}, 14:05:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:22 INFO - '--tppagecycles', 14:05:22 INFO - '7'], 14:05:22 INFO - 'tests': ['tsvgm']}}, 14:05:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:05:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:05:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:05:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'tests': ['damp', 'tps']}, 14:05:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['damp', 'tps']}, 14:05:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:05:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:22 INFO - 'other': {'tests': ['a11yr', 14:05:22 INFO - 'ts_paint', 14:05:22 INFO - 'tpaint', 14:05:22 INFO - 'sessionrestore', 14:05:22 INFO - 'sessionrestore_no_auto_restore']}, 14:05:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['a11yr', 14:05:22 INFO - 'ts_paint', 14:05:22 INFO - 'tpaint', 14:05:22 INFO - 'sessionrestore', 14:05:22 INFO - 'sessionrestore_no_auto_restore']}, 14:05:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['a11yr', 14:05:22 INFO - 'ts_paint', 14:05:22 INFO - 'tpaint', 14:05:22 INFO - 'sessionrestore', 14:05:22 INFO - 'sessionrestore_no_auto_restore']}, 14:05:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['a11yr', 14:05:22 INFO - 'ts_paint', 14:05:22 INFO - 'tpaint', 14:05:22 INFO - 'sessionrestore', 14:05:22 INFO - 'sessionrestore_no_auto_restore']}, 14:05:22 INFO - 'other_l64': {'tests': ['a11yr', 14:05:22 INFO - 'ts_paint', 14:05:22 INFO - 'tpaint', 14:05:22 INFO - 'sessionrestore', 14:05:22 INFO - 'sessionrestore_no_auto_restore']}, 14:05:22 INFO - 'other_nol64': {'tests': ['a11yr', 14:05:22 INFO - 'ts_paint', 14:05:22 INFO - 'tpaint', 14:05:22 INFO - 'sessionrestore', 14:05:22 INFO - 'sessionrestore_no_auto_restore']}, 14:05:22 INFO - 'svgr': {'tests': ['tsvgx', 14:05:22 INFO - 'tsvgr_opacity', 14:05:22 INFO - 'tart', 14:05:22 INFO - 'tscrollx', 14:05:22 INFO - 'cart']}, 14:05:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['tsvgx', 14:05:22 INFO - 'tsvgr_opacity', 14:05:22 INFO - 'tart', 14:05:22 INFO - 'tscrollx', 14:05:22 INFO - 'cart']}, 14:05:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'tests': ['tp5o']}, 14:05:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'talos_options': ['--e10s'], 14:05:22 INFO - 'tests': ['tp5o']}, 14:05:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'talos_options': ['--xperf_path', 14:05:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:22 INFO - 'tests': ['tp5n']}, 14:05:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:22 INFO - 'talos_options': ['--e10s', 14:05:22 INFO - '--xperf_path', 14:05:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 14:05:22 INFO - 'C:/slave/talos-data/talos/xperf.config'], 14:05:22 INFO - 'tests': ['tp5n']}}, 14:05:22 INFO - 'talos.zip': {'path': '', 14:05:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:22 INFO - Running post-action listener: _resource_record_post_action 14:05:22 INFO - ##### 14:05:22 INFO - ##### Running create-virtualenv step. 14:05:22 INFO - ##### 14:05:22 INFO - Running pre-action listener: _resource_record_pre_action 14:05:22 INFO - Running main action method: create_virtualenv 14:05:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:22 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 14:05:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:22 INFO - Using real prefix '/tools/python27' 14:05:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:23 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:26 INFO - Installing pip.................done. 14:05:26 INFO - Return code: 0 14:05:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:26 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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:26 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 14:05:26 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 14:05:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:26 INFO - 'HOME': '/Users/cltbld', 14:05:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:26 INFO - 'LOGNAME': 'cltbld', 14:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:26 INFO - 'MOZ_NO_REMOTE': '1', 14:05:26 INFO - 'NO_EM_RESTART': '1', 14:05:26 INFO - 'PAGER': '/bin/cat', 14:05:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:26 INFO - 'PWD': '/builds/slave/test', 14:05:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:26 INFO - 'SHELL': '/bin/bash', 14:05:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:26 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:26 INFO - 'USER': 'cltbld', 14:05:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:26 INFO - 'XPC_FLAGS': '0x0', 14:05:26 INFO - 'XPC_SERVICE_NAME': '0', 14:05:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:27 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 14:05:27 INFO - Cleaning up... 14:05:27 INFO - Return code: 0 14:05:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:27 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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:27 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 14:05:27 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 14:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:27 INFO - 'HOME': '/Users/cltbld', 14:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:27 INFO - 'LOGNAME': 'cltbld', 14:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:27 INFO - 'MOZ_NO_REMOTE': '1', 14:05:27 INFO - 'NO_EM_RESTART': '1', 14:05:27 INFO - 'PAGER': '/bin/cat', 14:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:27 INFO - 'PWD': '/builds/slave/test', 14:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:27 INFO - 'SHELL': '/bin/bash', 14:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:27 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:27 INFO - 'USER': 'cltbld', 14:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:27 INFO - 'XPC_FLAGS': '0x0', 14:05:27 INFO - 'XPC_SERVICE_NAME': '0', 14:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:27 INFO - Downloading/unpacking psutil>=0.7.1 14:05:27 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 14:05:27 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 14:05:27 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 14:05:27 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 14:05:27 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 14:05:27 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 14:05:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:05:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:30 INFO - Installing collected packages: psutil 14:05:30 INFO - Running setup.py install for psutil 14:05:30 INFO - building 'psutil._psutil_osx' extension 14:05:30 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 14:05:32 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 14:05:33 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 14:05:33 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 14:05:33 INFO - building 'psutil._psutil_posix' extension 14:05:33 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 14:05:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:05:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:05:33 INFO - ^ 14:05:33 INFO - 1 warning generated. 14:05:33 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 14:05:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:33 INFO - Successfully installed psutil 14:05:33 INFO - Cleaning up... 14:05:33 INFO - Return code: 0 14:05:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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', '--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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:33 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 14:05:33 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 14:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:33 INFO - 'HOME': '/Users/cltbld', 14:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:33 INFO - 'LOGNAME': 'cltbld', 14:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:33 INFO - 'MOZ_NO_REMOTE': '1', 14:05:33 INFO - 'NO_EM_RESTART': '1', 14:05:33 INFO - 'PAGER': '/bin/cat', 14:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:33 INFO - 'PWD': '/builds/slave/test', 14:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:33 INFO - 'SHELL': '/bin/bash', 14:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:33 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:33 INFO - 'USER': 'cltbld', 14:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:33 INFO - 'XPC_FLAGS': '0x0', 14:05:33 INFO - 'XPC_SERVICE_NAME': '0', 14:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:05:34 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 14:05:34 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 14:05:34 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 14:05:34 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 14:05:34 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 14:05:34 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 14:05:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:05:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:05:36 INFO - Installing collected packages: mozsystemmonitor 14:05:36 INFO - Running setup.py install for mozsystemmonitor 14:05:36 INFO - Successfully installed mozsystemmonitor 14:05:36 INFO - Cleaning up... 14:05:36 INFO - Return code: 0 14:05:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:36 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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:36 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 14:05:36 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 14:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:36 INFO - 'HOME': '/Users/cltbld', 14:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:36 INFO - 'LOGNAME': 'cltbld', 14:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:36 INFO - 'MOZ_NO_REMOTE': '1', 14:05:36 INFO - 'NO_EM_RESTART': '1', 14:05:36 INFO - 'PAGER': '/bin/cat', 14:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:36 INFO - 'PWD': '/builds/slave/test', 14:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:36 INFO - 'SHELL': '/bin/bash', 14:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:36 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:36 INFO - 'USER': 'cltbld', 14:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:36 INFO - 'XPC_FLAGS': '0x0', 14:05:36 INFO - 'XPC_SERVICE_NAME': '0', 14:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:37 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:37 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 14:05:37 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 14:05:37 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 14:05:37 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 14:05:37 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 14:05:37 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 14:05:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:39 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 14:05:39 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 14:05:39 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 14:05:39 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 14:05:39 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 14:05:39 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 14:05:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:40 INFO - Downloading docopt-0.6.1.tar.gz 14:05:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:40 INFO - Running setup.py install for blobuploader 14:05:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:40 INFO - Running setup.py install for requests 14:05:41 INFO - Running setup.py install for docopt 14:05:41 INFO - Successfully installed blobuploader requests docopt 14:05:41 INFO - Cleaning up... 14:05:41 INFO - Return code: 0 14:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:41 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')]} 14:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:41 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')]} 14:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:41 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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:41 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 14:05:41 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 14:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:41 INFO - 'HOME': '/Users/cltbld', 14:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:41 INFO - 'LOGNAME': 'cltbld', 14:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:41 INFO - 'MOZ_NO_REMOTE': '1', 14:05:41 INFO - 'NO_EM_RESTART': '1', 14:05:41 INFO - 'PAGER': '/bin/cat', 14:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:41 INFO - 'PWD': '/builds/slave/test', 14:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:41 INFO - 'SHELL': '/bin/bash', 14:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:41 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:41 INFO - 'USER': 'cltbld', 14:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:41 INFO - 'XPC_FLAGS': '0x0', 14:05:41 INFO - 'XPC_SERVICE_NAME': '0', 14:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-GYW_vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-1XubxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-kv4kY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-E5Fjwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-gHL7Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-TZMfnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-tV9PDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:42 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-63tAsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-5ySm3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-OLBtjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-upF7Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-wCeDCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-yhNdiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-2krx_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-HJHl4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:43 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-WtsFPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:44 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-CNuQZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:44 INFO - Running setup.py install for manifestparser 14:05:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:05:44 INFO - Running setup.py install for mozcrash 14:05:44 INFO - Running setup.py install for mozdebug 14:05:44 INFO - Running setup.py install for mozdevice 14:05:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:05:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:05:44 INFO - Running setup.py install for mozfile 14:05:45 INFO - Running setup.py install for mozhttpd 14:05:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Running setup.py install for mozinfo 14:05:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Running setup.py install for mozInstall 14:05:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Running setup.py install for mozleak 14:05:45 INFO - Running setup.py install for mozlog 14:05:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:05:45 INFO - Running setup.py install for moznetwork 14:05:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:05:46 INFO - Running setup.py install for mozprocess 14:05:46 INFO - Running setup.py install for mozprofile 14:05:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:05:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:05:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:05:46 INFO - Running setup.py install for mozrunner 14:05:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:05:46 INFO - Running setup.py install for mozscreenshot 14:05:46 INFO - Running setup.py install for moztest 14:05:46 INFO - Running setup.py install for mozversion 14:05:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:05:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:47 INFO - Cleaning up... 14:05:47 INFO - Return code: 0 14:05:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:47 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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:47 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 14:05:47 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 14:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:47 INFO - 'HOME': '/Users/cltbld', 14:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:47 INFO - 'LOGNAME': 'cltbld', 14:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:47 INFO - 'MOZ_NO_REMOTE': '1', 14:05:47 INFO - 'NO_EM_RESTART': '1', 14:05:47 INFO - 'PAGER': '/bin/cat', 14:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:47 INFO - 'PWD': '/builds/slave/test', 14:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:47 INFO - 'SHELL': '/bin/bash', 14:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:47 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:47 INFO - 'USER': 'cltbld', 14:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:47 INFO - 'XPC_FLAGS': '0x0', 14:05:47 INFO - 'XPC_SERVICE_NAME': '0', 14:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:47 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-80AINP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:47 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)) 14:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:47 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-EiAH3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:47 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)) 14:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:47 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-BOkdhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:47 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)) 14:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:47 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-8M7EkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:47 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)) 14:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:47 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-iwegyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-lj8AjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-oUk_96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-3DdNsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-UWXKJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-gfima1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-YVXepK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-XlqqTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:48 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)) 14:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:48 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-k1Evws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:49 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)) 14:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:49 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-baPDaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:49 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)) 14:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:49 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-q4ic0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:49 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)) 14:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:49 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-9ODMQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:49 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)) 14:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:49 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-k7ylXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:49 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)) 14:05:49 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)) 14:05:49 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)) 14:05:49 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)) 14:05:49 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)) 14:05:49 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)) 14:05:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:51 INFO - Downloading blessings-1.5.1.tar.gz 14:05:51 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 14:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:52 INFO - Installing collected packages: blessings 14:05:52 INFO - Running setup.py install for blessings 14:05:52 INFO - Successfully installed blessings 14:05:52 INFO - Cleaning up... 14:05:52 INFO - Return code: 0 14:05:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:52 INFO - Reading from file tmpfile_stdout 14:05:52 INFO - Current package versions: 14:05:52 INFO - blessings == 1.5.1 14:05:52 INFO - blobuploader == 1.2.4 14:05:52 INFO - docopt == 0.6.1 14:05:52 INFO - manifestparser == 1.1 14:05:52 INFO - mozInstall == 1.12 14:05:52 INFO - mozcrash == 0.16 14:05:52 INFO - mozdebug == 0.1 14:05:52 INFO - mozdevice == 0.46 14:05:52 INFO - mozfile == 1.2 14:05:52 INFO - mozhttpd == 0.7 14:05:52 INFO - mozinfo == 0.8 14:05:52 INFO - mozleak == 0.1 14:05:52 INFO - mozlog == 3.0 14:05:52 INFO - moznetwork == 0.27 14:05:52 INFO - mozprocess == 0.22 14:05:52 INFO - mozprofile == 0.27 14:05:52 INFO - mozrunner == 6.11 14:05:52 INFO - mozscreenshot == 0.1 14:05:52 INFO - mozsystemmonitor == 0.0 14:05:52 INFO - moztest == 0.7 14:05:52 INFO - mozversion == 1.4 14:05:52 INFO - psutil == 3.1.1 14:05:52 INFO - requests == 1.2.3 14:05:52 INFO - wsgiref == 0.1.2 14:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:52 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 0x10349aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103507228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e9502e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, '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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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 14:05:52 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 14:05:52 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 14:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:52 INFO - 'HOME': '/Users/cltbld', 14:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:52 INFO - 'LOGNAME': 'cltbld', 14:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:52 INFO - 'MOZ_NO_REMOTE': '1', 14:05:52 INFO - 'NO_EM_RESTART': '1', 14:05:52 INFO - 'PAGER': '/bin/cat', 14:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:52 INFO - 'PWD': '/builds/slave/test', 14:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:52 INFO - 'SHELL': '/bin/bash', 14:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:05:52 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:52 INFO - 'USER': 'cltbld', 14:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:52 INFO - 'XPC_FLAGS': '0x0', 14:05:52 INFO - 'XPC_SERVICE_NAME': '0', 14:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 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)) 14:05:53 INFO - Cleaning up... 14:05:53 INFO - Return code: 0 14:05:53 INFO - Running post-action listener: _resource_record_post_action 14:05:53 INFO - Running post-action listener: _start_resource_monitoring 14:05:53 INFO - Starting resource monitoring. 14:05:53 INFO - ##### 14:05:53 INFO - ##### Running install step. 14:05:53 INFO - ##### 14:05:53 INFO - Running pre-action listener: _resource_record_pre_action 14:05:53 INFO - Running main action method: install 14:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:53 INFO - Reading from file tmpfile_stdout 14:05:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:05:53 INFO - Reading from file tmpfile_stdout 14:05:53 INFO - Output received: 14:05:53 INFO - Usage: mozinstall [options] installer 14:05:53 INFO - Options: 14:05:53 INFO - -h, --help show this help message and exit 14:05:53 INFO - -d DEST, --destination=DEST 14:05:53 INFO - Directory to install application into. [default: 14:05:53 INFO - "/builds/slave/test"] 14:05:53 INFO - --app=APP Application being installed. [default: firefox] 14:05:53 INFO - mkdir: /builds/slave/test/build/application 14:05:53 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'] 14:05:53 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 14:06:30 INFO - Reading from file tmpfile_stdout 14:06:30 INFO - Output received: 14:06:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:06:30 INFO - Running post-action listener: _resource_record_post_action 14:06:30 INFO - ##### 14:06:30 INFO - ##### Running run-tests step. 14:06:30 INFO - ##### 14:06:30 INFO - Running pre-action listener: _resource_record_pre_action 14:06:30 INFO - Running main action method: run_tests 14:06:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:30 INFO - 2015-11-30 14:06:30.892 screenresolution[1637:8700] starting screenresolution argv=screenresolution get 14:06:30 INFO - 2015-11-30 14:06:30.896 screenresolution[1637:8700] Display 0: 1600x1200x32@60 14:06:30 INFO - 2015-11-30 14:06:30.902 screenresolution[1638:8702] starting screenresolution argv=screenresolution list 14:06:30 INFO - Available Modes on Display 0 14:06:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:31 INFO - Intel HD Graphics 3000: 14:06:31 INFO - Chipset Model: Intel HD Graphics 3000 14:06:31 INFO - Type: GPU 14:06:31 INFO - Bus: Built-In 14:06:31 INFO - VRAM (Total): 512 MB 14:06:31 INFO - VRAM (Dynamic, Max): 10 14:06:31 INFO - Vendor: Intel (0x8086) 14:06:31 INFO - Device ID: 0x0116 14:06:31 INFO - Revision ID: 0x0009 14:06:31 INFO - Displays: 14:06:31 INFO - Display: 14:06:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:31 INFO - Display Serial Number: 1600x1200 60 14:06:31 INFO - Main Display: Yes 14:06:31 INFO - Mirror: Off 14:06:31 INFO - Online: Yes 14:06:31 INFO - Rotation: Supported 14:06:31 INFO - Return code: 0 14:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:31 INFO - Python 2.7.3 14:06:31 INFO - Return code: 0 14:06:31 INFO - grabbing minidump binary from tooltool 14:06:31 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')]} 14:06:31 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 0x10344f9f0>, '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 0x1031aecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103419990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:31 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 14:06:31 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 14:06:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:31 INFO - Return code: 0 14:06:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:06:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:06:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:31 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/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0050', '--webServer', 'localhost'] in /builds/slave/test/build 14:06:31 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/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0050 --webServer localhost 14:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bJYPHQEeuE/Render', 14:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:31 INFO - 'HOME': '/Users/cltbld', 14:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:31 INFO - 'LOGNAME': 'cltbld', 14:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:31 INFO - 'MOZ_NO_REMOTE': '1', 14:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:31 INFO - 'NO_EM_RESTART': '1', 14:06:31 INFO - 'PAGER': '/bin/cat', 14:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:31 INFO - 'PWD': '/builds/slave/test', 14:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:31 INFO - 'SHELL': '/bin/bash', 14:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LT6ezA4z9r/Listeners', 14:06:31 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 14:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:31 INFO - 'USER': 'cltbld', 14:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:31 INFO - 'XPC_FLAGS': '0x0', 14:06:31 INFO - 'XPC_SERVICE_NAME': '0', 14:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:06:31 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/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0050', '--webServer', 'localhost'] with output_timeout 3600 14:06:31 INFO - mozversion INFO | application_buildid: 20151130131332 14:06:31 INFO - mozversion INFO | application_changeset: 27a9ba2d01e9f0b987f1debb45e782d84a896d37 14:06:31 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:06:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:31 INFO - mozversion INFO | application_name: Firefox 14:06:31 INFO - mozversion INFO | application_remotingname: firefox-dev 14:06:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:06:31 INFO - mozversion INFO | application_vendor: Mozilla 14:06:31 INFO - mozversion INFO | application_version: 44.0a2 14:06:31 INFO - mozversion INFO | platform_buildid: 20151130131332 14:06:31 INFO - mozversion INFO | platform_changeset: 27a9ba2d01e9f0b987f1debb45e782d84a896d37 14:06:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:06:31 INFO - mozversion INFO | platform_version: 44.0a2 14:06:31 INFO - 2015-11-30 14:06:31,818 DEBUG : using testdate: 1448921191 14:06:31 INFO - 2015-11-30 14:06:31,818 DEBUG : actual date: 1448921191 14:06:31 INFO - 2015-11-30 14:06:31,828 INFO : starting webserver on 'localhost:49267' 14:06:31 INFO - 2015-11-30 14:06:31,829 INFO : Starting test suite t-yosemite-r5-0050 14:06:31 INFO - 2015-11-30 14:06:31,829 INFO : Starting test dromaeo_css 14:06:31 INFO - 2015-11-30 14:06:31,829 DEBUG : operating with platform_type : mac_ 14:06:31 INFO - 2015-11-30 14:06:31,830 INFO : Initialising browser for dromaeo_css test... 14:06:31 INFO - 2015-11-30 14:06:31,858 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpEsFlSM/profile http://localhost:49267/getInfo.html 14:06:34 INFO - 2015-11-30 14:06:34,764 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:06:34 INFO - 2015-11-30 14:06:34,764 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:06:34 INFO - 2015-11-30 14:06:34,764 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:06:34 INFO - 2015-11-30 14:06:34,764 DEBUG : BROWSER_OUTPUT: __metrics 14:06:34 INFO - 2015-11-30 14:06:34,782 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:35 INFO - 2015-11-30 14:06:35,473 INFO : Browser initialized. 14:06:35 INFO - 2015-11-30 14:06:35,474 INFO : Running cycle 1/1 for dromaeo_css test... 14:06:35 INFO - 2015-11-30 14:06:35,474 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpEsFlSM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:06:47 INFO - 2015-11-30 14:06:47,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 200499200 14:06:47 INFO - 2015-11-30 14:06:47,393 DEBUG : BROWSER_OUTPUT: 14:07:39 INFO - 2015-11-30 14:07:39,169 DEBUG : BROWSER_OUTPUT: 1448921259167 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] 14:09:49 INFO - 2015-11-30 14:09:49,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 14:09:50 INFO - 2015-11-30 14:09:50,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 315117568 14:09:50 INFO - 2015-11-30 14:09:50,752 DEBUG : BROWSER_OUTPUT: 14:12:53 INFO - 2015-11-30 14:12:53,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 14:12:53 INFO - 2015-11-30 14:12:53,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 342564864 14:12:53 INFO - 2015-11-30 14:12:53,891 DEBUG : BROWSER_OUTPUT: 14:15:55 INFO - 2015-11-30 14:15:55,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 14:15:56 INFO - 2015-11-30 14:15:56,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 307150848 14:15:56 INFO - 2015-11-30 14:15:56,513 DEBUG : BROWSER_OUTPUT: 14:18:58 INFO - 2015-11-30 14:18:58,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 14:18:59 INFO - 2015-11-30 14:18:59,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 298160128 14:18:59 INFO - 2015-11-30 14:18:59,059 DEBUG : BROWSER_OUTPUT: 14:22:02 INFO - 2015-11-30 14:22:02,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 14:22:02 INFO - 2015-11-30 14:22:02,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 298504192 14:22:02 INFO - 2015-11-30 14:22:02,851 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 14:25:05 INFO - 2015-11-30 14:25:05,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 344231936 14:25:05 INFO - 2015-11-30 14:25:05,660 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,660 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:25:05 INFO - 2015-11-30 14:25:05,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:25:05 INFO - 2015-11-30 14:25:05,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:25:05 INFO - 2015-11-30 14:25:05,661 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:25:05 INFO - 2015-11-30 14:25:05,665 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3076.123304858113;3210.8394580270988;3263.314703912177;3289.967100328996;3326.9001929942096;5421.457854214576;5472.370677372103;5487.506124448799;5514.917276240854;5553.38912719601;5315.0698627740185;5394.05604019297;5414.810481633143;5445.319335083114;5457.263269458622;4837.685550439211;4958.652894297401;5012.924806127911;5058.696478211301;5063.063333283336;4905.068037072962;4953.504649535035;5029.044481548494;5051.343325367716;5052.368453943257;5015;5124.231365295217;5136.948630513703;5144.4598317176715;5189.403218629849;4951.158303088484;5038.773255203525;5084.567811736007;5119.206522988924;5183.637145399824;4908.9263661045115;5074.467180945984;5075.035743208816;5087.516685914869;5091.261767043795;5169.870753231199;5213.32226810516;5224.73876306187;5248.790048398059;5260.947390526084;5574.1917421973585;5577.944220557783;5612.663240205601;5730.570207234432;5806.506446951972;5384.515393614593;5504.311961004874;5508.091164957777;5616;5635.633683810539;5207.0887594670785;5218.191180367049;5269.262303277545;5334.119870221409;5338.172583249602;5665.773369065191;5724.971375143097;5770.19217309577;5806.390329015477;5863.3257175424515;5528.668279903219;5580.2466666999435;5590.608657393944;5601.327840659147;5606.327240731139;5725.112607545837;5824.912626310609;5831.241938547962;5833.125031245262;5862.736176872051;5402.324709411324;5447.155690867922;5522.779088836402;5574.665520068809;5666.716664166775;5659.886802263932;5677.914831277534;5753.4821866031425;5772.163036359789;5854.4730974212525;4383.912321753547;4399.450068741407;4400.141972315368;4437.445319335083;4447.844325448594;3739.139997800521;3844.8654297099465;3953.584873588289;3977.0455090778005;4049.453323801308;5302.151655735064;5437.238786569884;5440.646357986798;5452.890942181134;5464.371597266286;5792.913106303409;5799.859512078535;5811.564132690065;5895;5951.809638072403;5209.0363282792805;5314.362276526842;5339.546138578186;5368.409474957752;5402.864928376822;5031.094403007493;5069.087564238473;5107.33604631403;5107.978404319151;5127.769250383742;5845.853853653693;5855.736491857791;5928.822135335947;5949.702514874239;6052;5562.110062389998;5628.943710562842;5698.031334673198;5726.112452569859;5766.798162064308;5783.16144159103;5795;5821.27234095738;5882.441168089024;5915.615484993634;5623.044082506066;5634.211210430461;5642.294713160855;5645.1532270159805;5693.914591281051;5627.8874422512135;5634.943650563606;5742.483176514133;5836.883262334814;5916.112583112567;5528.55771538284;5588.329400471969;5641.971790141023;5642.85892852682;5685.488306052475;5394.163904594794;5576.358718747234;5586.441355864381;5655.151727240782;5677.716114194356;5211.140161873249;5312.442193569774;5356.598255130959;5493.478119578634;5530.364008139116;5643.125315576092;5692;5701.743421545957;5793.507551858139;5826.271716035496;5572.749226284745;5588.972055139861;5593.356763972195;5624.29696287964;5681.545476361964 14:25:05 INFO - 2015-11-30 14:25:05,665 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.2751677852349;567.7274908044136;569.5984331046612;576.7981206577698;607.0257237134397;31877.36245275093;33041.339173216555;40711.592884071186;41224.38163427551;41398.379024314585;43189.784051079776;43390.56609433905;43764;43972.3404148938;44257.557424425744;8455.239028487435;9102.817943641123;9421.199198068172;9429.952850235739;9471.10024547667;8655.177758113;11030.558777648885;11283.943580282086;11324.207305488619;11337.829932551018;11019.449027548631;11035.613753518628;11169.273997190197;11201.159913006517;11222.214444988855;8717.171868672465;9027.277817774562;10817.080548153417;10958.671239862777;11042.613508527204;10329.380237185793;11009.61466348682;11029.117670586334;11030.28303160292;11080.501377438035;38764.41853372202;40363.7981810092;40595.59404405948;40709;40906.386404203964;2874.3101655602713;3029.681883402255;3161.920951976196;3564.0733409313507;3579.9105022374647;27254;27309.590356144672;27513.17460476189;28132;28234.43531129366;2279.87460689662;2317.8377513574055;2351.376885125443;2370.9686286465444;2373.8575685458754;272392;273395;276182;277211;279148.6042569794;59912;64236.35763642397;64563.354366456675;64940;65310;56218.437815622136;72589.2741072593;72644.63677681578;72988.63505682438;73681.6315918417;17465.912670436566;17499.300027998994;17631.559211019827;17682.646347072987;17692.557686057953;12903.741925161445;13129.60611181666;13274.336283185996;13394.598162055154;13396.665083372995;20001.199952002047;20826.791732082787;20855.58288834245;21153.89423052875;21155.25956591512;8343.624536895853;8606.397552171413;8634.827303454022;8669.436486628349;8673.783155421164;920.5351297594806;991.8016396720685;1034.4879284754095;1082.637316498966;1118.7930232906938;28623.284417889718;28722.425551488854;28870;29127.12618621445;29143.85428072846;1019.918406527476;1022.6880801355509;1053.7260312318851;1077.2836064017497;1099.7525556749667;12859.935700321626;14187.645308867155;14267.296521033635;14430.134191948517;15059.548213553611;332438;340437;340443;341763;343991;56728;56919.86160276771;57185;57360.71319643375;58082.7095864518;1325.4499382756048;1407.7677183264648;1425.237497938598;1440.1790979141997;1456.4683890379936;27989.160325190278;29066.56400153957;29091;29455;30167.396652066396;46657.533424666675;46728;47726.284105737745;47728.28407573959;48349.7912552175;185465;275362;275475;281536;282016;30997;31347;31409.842950786013;31751.364972700878;32068.83965580157;40857.38713919353;41843.581564183965;41997.37003945004;43391;43432.782836085615;34403.311933760684;35776.28447431089;35834;36136.63863361333;36436.27127457489;35019.29961400707;35350.46974295439;35556.11109722174;36267.637323626426;36774;33342.83328583342;34109;34137.658623413445;34197.316053679286;34347.656523434445;28649;30215.395692085596;30505.694943050286;30559.847200763856;31689.5246571297;24050.39874003164;24345.39136521601;24527.632085518373;24721.381965450288;24870.626940595543 14:25:05 INFO - 2015-11-30 14:25:05,669 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.5596488336902;357.15354609575303;359.40339037198254;363.53649097400813;365.1164182677919;14647.633809154777;14913.478028268986;17580.56048598784;17860.73208901866;18668.813311866877;11900.46447909844;12252.509899604027;15077.54767356981;18061.548461288476;18238.908805455987;4359.215341238568;4417.469903611571;4472.172648060103;4490.730556166624;4527.501974782771;3446.5347178131005;3484.233468636896;4392.275274579691;4469.530699276578;4790.976045119787;4796.568308852203;4862.805487780484;4877.9268310975185;4885.145099607572;4915.778789954443;4806.807727690888;4858.927116093279;4862;4871.12319782439;4975.477574854661;4225.746455212667;4256.59562341577;4259.998900258437;4269.594388533084;4281.443412356373;13743.725125497534;13763.449462021606;13957.720845583133;13998.160110393306;14032.807211387044;1884.415831092352;1893.7916829148783;1963.7545306836646;1993.9202431902706;2017.1628774058747;9252.722418327461;9345.953270233673;9789.559469823875;10174.847377289347;10274.845877311845;1603.879709021828;1613.9273732682057;1615.8949668271525;1637.8280280570489;1657.6187476880264;55145;56018.43981560173;59827.70086149542;63264;63482.99999999954;6691.933080669229;6778;6810.489213308922;6870.416014638811;6881.898896176588;7839.490433121829;7857.214278572212;7886.369090472748;7902.604869756489;7922.603869806487;5537.197106419547;5706.343770466449;5731.455511726463;5749.597528173072;5753.453421924911;6105.13793293041;6140.692965351804;6188.071789231652;6205.565610407228;6209.006558950637;3056.9235769105508;3065.494193458099;3118.703723146343;3141.4031334046913;3146.5594816725675;1057.7778666479971;1067.8291473364225;1093.1254996003165;1123.8370436286857;1141.9257748246337;419.1093925408507;430.42323286795846;434.6501066641384;437.5012485766229;452.4412350746825;11768.176227663982;11851.703707407383;11930.821037684442;12401.813972790414;13028.54400095992;445.37869671807647;454.0510333403203;457.3756821938097;480.9731223837133;501.0880198039606;6243.313235544087;6418.967905160444;6495.64273964927;6502.739890404426;6518.543701940914;571914;574818;576187;593262;606783;67815.66092169606;68617;68823.31176688269;69815.30184698189;69821.65089174623;460.49805711774326;466.24468361254986;466.79694332965266;466.8716103071682;499.7850924102598;10895.945520272347;10987.945060274647;11031.669049928514;11182.66452006441;11300.434978251218;35932.4610130843;36315.27369452544;36316.63683363238;36341;37205.81397092997;50715.49284507108;50897.69165004263;50918.49081509285;51054.23418648798;51447.742761285954;6507.837304067436;6541.934580654132;6556.63938483388;6557.442617377385;6568.671566421564;11811.468483918416;12175;12184.817227741769;12379.381030948596;12447.439865206268;9802.166815820736;10351;10585.206109541661;10674.985876341736;10806.945965270437;10121.493925303557;10170.186385089322;10242.129418999468;10374.118199953089;10564.260501764802;8390.874136888073;10476.842847357144;10769.24615276923;10870.945645271722;10873.347599144077;6391.616503009648;6426.775062872777;6493.675316234264;6570.8028759137305;6575.50683698715;10506.737331566772;10511.159107271247;10846.511906964364;10847.077998369912;10891.67324980252 14:25:05 INFO - 2015-11-30 14:25:05,669 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1295.2940647347195;1391.1792042694808;1401.8317801863777;1585.476792658423;1851.1854783895094;6723.529352945289;7306.452016098788;7328.816779580513;7408;7432.888506672391;7216.134063912338;7474.364679002291;7480.7755767326935;7496.137944136426;7632.809179770495;2020.3938818354509;2092.811646951774;2101.8949052547387;2108.599366120432;2138.77542858;2147.9892600537055;2196.2093646287326;2200.845940784138;2219.6670499425054;2227.8106360959337;2129.510212651091;2129.84026198035;2137.8075973162413;2145.0776166248506;2155.665871789875;2086.7704552499213;2112.7781582933803;2120.5440830221423;2127.7872212778752;2145.442185031887;2165.2962787094098;2173.3588591365583;2200.2189222825828;2202.5484775620957;2208.4589275627413;6712.563683360615;6795.524313298071;7342.082239720035;7398.038255026866;7412.18465968743;4461.263891457906;4536.364908912755;4556.430446194226;4591.6097131743845;4599.770011499445;2687.583424569195;2699.9595006074924;2725.9318517037036;2788.9302767430977;2811.072346125794;865.8354912566592;868.3443999780188;883.7039591736776;884.2881480408269;884.7390019944067;9630.229581633523;9743.464109473976;9780.608775648965;9799.461029643368;9826.017398260188;4049.331860243086;4131.97934010334;4138.193052354762;4185.727927684691;4211.663066954698;8770.693025744069;8832.77918052041;8855.911440885637;8884.37809353339;8896.110388961051;4626.051659409813;4650.720956742606;4653.906921861611;4654.604358629486;4661.300804879295;4221.2190744712325;4268.509121451073;4268.829246830154;4272.700910936204;4279.186954478639;3442.242706604593;3454.274602333488;3457.2048428861503;3485.912852178665;3498.5626796650417;1095.5070218401593;1100.7523307255963;1105.2594761509808;1111.9277246979082;1117.0560876059717;1256;1270.01573780321;1293.9158954667917;1306.3468265867066;1344.0793056756154;6726.9657859430035;6802.591844489347;7060.7881763547175;7102.218755936843;7147.89278160828;480.4042986696471;492.4804331430304;493.03857477918206;494.6982340772126;497.1027295731168;5281.181416880389;5328.786848526093;5344.4922732340365;5377.5429088527135;5485.561155107662;7844.725434609762;8435.283000944866;8514.957425212959;8573.014103378191;8591.097934716765;7942.841143177104;8350.916490835136;8353.457025293337;8456.238938495442;8507.149285071444;6635.10426092481;6716.865662686817;6825.010373495816;6829.556078854958;6841.863162736718;6675.632840193836;6754.459643228432;6767.39093481589;6772.424343930624;6806.319368063154;7467.215942325977;7626.885596716164;7679.961600191963;7688.038995125609;7728.497647652885;7783.377329813715;7843.803904902423;7904.486208396436;7914.6834126636595;7928.445008849556;6476.5466417350335;6506.186726659168;6509.4792416605615;6523.510736694861;6529.542931994714;7004.544704594185;7005.474589405917;7032.261612530815;7053.224145344111;7150.998860159478;6240.937590624036;6370.012648039561;6416.647084410216;6461.67691615408;6511.34886511345;6480.902786458113;6522.967385163044;6564.277929427854;6576.506761992965;6582.967085164543;6367.140436041075;6409;6423.03654451836;6521.250056243593;6522.445592124723;5539.833804985857;5866.3547009828035;5909.9066672665695;5925.1704761332585;5964;5985.132155837467;6013.067974463965;6046.969765151146;6057.545684073624;6064.848378790565 14:25:05 INFO - 2015-11-30 14:25:05,672 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.6601568353229;323.7701232125191;326.1259823672558;326.769627412674;329.41857621298396;6130.356312587181;6162.907556386658;6189.226346706661;6202.379762023796;6245.469135123514;6047.244094488189;6058.787942422016;6063.060225665018;6072.453479186872;6092.66490343031;4720.409948756405;4721.480637129913;4732.384789977298;4781.928271075936;4817.253325734508;4677;4749.833755818547;4804.5916097131785;4813.66304358695;4873.147199240118;4722.929156062662;4745.57289843914;4748.145333839908;4762.404699412574;4782.97608511957;4550.408446901914;4769.165396055711;4773.140834649762;4775.259834725605;4799.712017278975;4011.959880401217;4014.337634290368;4094.836206551764;4141.4409054777825;4180.268453020709;5856.619319744203;5903.026000709878;5903.911441328383;5913.733881975279;5979.043353063489;5070.467600901926;5090.261912022736;5107.846764597068;5184.7148406837605;5243.86890327741;6264.248290205204;6278.811635650938;6301.873962520724;6310.432061114522;6311.305756366796;4338.717983331074;4346.0655958968655;4348;4382.145481631083;4399.098184872126;6470.644114573696;6633.535652504278;6658.13444252249;6773.762918297836;6794.048833163361;4417.955820441819;4438.800253988578;4474.194644963873;4527.909441811145;4550.476695180097;4431.357453169272;4511.571400716926;4532.297493888453;4605.769711514411;4626.097910907408;5200.97399513;5203.089459344676;5239.895202095937;5277.340332458442;5315.973420132952;6142.262928448615;6181.443670069625;6353.047042943595;6405.3594640535575;6415.871682566322;1588.793456850625;1614.023515772964;1632.2410079313177;1632.8693704503612;1639.8278180790844;1060.9787804243872;1077.5528155815248;1082.680609220282;1092.4428541443922;1107.9944600276947;6101;6114.755409783559;6130;6135.202423684982;6152.8769424611255;6652.833679157963;6664.133662623828;6682.866342673119;6687.598744075371;6767.35710107539;5953.28560572734;6075.210222671113;6111.54163437735;6137.508999280047;6170.10533472644;3564.572251329857;3600.0459878132315;3667.2665466906724;3680.392735198716;3687.2809802088336;6665.533412661067;6717.429018533382;6744.055832183498;6766.15423072116;6781.9827025945515;6365.2998170201245;6725.125733654593;6759.222689390783;6809.148856392951;6832.624205668637;6152.630842149485;6548.9017664735065;6582.670866456658;6797.422219111233;6893.276205998298;6649.700763465559;6724.361185687352;6725.798226053226;6733.42765864907;6790.083338749206;6511.837204069936;6526.118973938457;6596.571222870498;6614.437772789367;6683.465322774264;6597.175353080865;6712.49656275791;6733.360330768569;6769.661516924232;6783.016462612992;4165.271077561354;4185.5605161458825;4194.391813187131;4221.7255878367805;4245.257080011047;6537.378948999837;6550.377714117151;6557.9344206557325;6598.142241508765;6660.766873159416;6299.905501417391;6368.872622547616;6470.48236141117;6475.3200913903365;6488.967555162194;6438.356164383712;6438.484921206386;6455.709493072729;6466.902996455151;6471.094046833541;6252.343503932204;6275.937240627535;6279.277883043508;6318.304986451579;6366.267879193952;6234.781782637586;6397.360263973565;6408.070829729756;6411.455026322815;6451.1936007999;6347.873042539031;6367.07677386767;6383.457406120346;6397.040443933447;6409.102725618324 14:25:05 INFO - 2015-11-30 14:25:05,673 DEBUG : BROWSER_OUTPUT: |5;yui.html;636.6116668832011;643.173522024199;690.1752405874978;770.5338270346442;781.1212386065677;12993.480260789569;13201.405936732857;13447.932760336209;13486.12340197889;13568.457261709533;12899.419526121324;12939.094263401566;13048.608541743739;13103.14829536082;13127.0811043227;735.56601605053;743.1156923261302;884.8407286688393;895.7312806158159;906.4334790755778;893.70954439807;901.9413738107002;911.1844898815589;912.238281035333;917.0187898948128;929.2612373163352;940.407543247753;940.6049459227107;942.3215284994827;945.5981207986613;750.0848964263616;767.9232076792332;925.273660176758;944.6929747831982;959.2278216036088;682.0860047536326;699.7655785311927;700.4501466348943;703.4407645921505;715.5527795128045;12507.124501284914;12671.36643167847;12786.296753678544;12828.743425131539;12836.358182090858;11246.887531124667;11437.142214333875;11576.768464630744;11848.763024739457;12035.939820300842;9190.586423610954;9225.953870230605;9341.346105772598;9435.858462123073;9517.428954262698;3252.4796032634663;3391.5082313064713;3392.4572068469174;3398.694117529434;3473.7568370214094;47609.523904761205;48238;48323.51676483225;49242.50757492415;50155.999999999636;8790;8891.599878005505;8967.372283940062;8994.595243214071;9033.593488293043;12068.09489288307;12108.939455302667;12315.384230788424;12399.504019839285;12408.441620127116;5800.854978625568;5819.476247137778;5928.466438020599;5979.162917191509;6065.514758819284;3374.578177727784;3481.7562770606323;3483.1466290758926;3596.4065929121402;3754.0990162360836;2576.4203054313007;2602.843829370244;2604.70045944715;2613.5426300397353;2640.353113487208;395.1997205658507;404.2501160347572;405.0905716666045;408.844639037164;409.17346959142367;459.9862004139881;463.53414818107586;480.79085597765084;510.6782726882115;590.9940900591025;7315.780526584211;7354.669039893218;7397.667104980289;7445.362020355513;7480.438967077491;461.2757969987088;461.7621924708778;461.93301971213987;501.55612283129693;507.82315455379944;3259.4784834426378;3367.915802104918;3469.098034511045;3500.299940012008;3519.1202199450136;61569.692151538955;61824;61856;62004;62927.685361573815;51155;53033;53318.200226996625;53950;53974.73012634912;47085.76457117761;47845;48214;48650.75674621675;48841.755791220814;6860.451163906776;6910.378065973885;6965.059716938148;7010.298970102949;7027.754028608974;33586.66413335933;34358.31283374369;34718.82640586882;34770.478442822874;35314.92640225366;43379.132417352106;44439;45370.54629453663;47251.29123063088;47466;6406.615603063831;6550.574212676161;6694.799156025327;6769.086173366532;6836.145481814773;10092.747681307732;10168.593256269667;10258.794824103326;10295.330803497749;10380.636677716244;9063.229625481645;9701.563429645825;9759.268054896052;9911.702648920544;9944.105030547285;9412.858807117762;9501;9568.904310956801;9579.760505987406;9707.077827606367;9139.817203655757;9349.25205983506;9527.618895244113;9611;9627.9037209627;8279.793005174919;8310;8376.748697539084;8908.955455222682;9256.629734810533;8060.476069055492;8145.755627331189;8147.266745992889;8909.242714369091;9025.819483610423 14:25:05 INFO - 2015-11-30 14:25:05,673 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:25:05 INFO - 2015-11-30 14:25:05,673 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:25:05 INFO - 2015-11-30 14:25:05,673 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 14:25:05 INFO - 2015-11-30 14:25:05,674 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:25:05 INFO - 2015-11-30 14:25:05,675 DEBUG : BROWSER_OUTPUT: __startTimestamp1448922305659__endTimestamp 14:25:05 INFO - 2015-11-30 14:25:05,675 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,675 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:25:05 INFO - 2015-11-30 14:25:05,675 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:25:05 INFO - 2015-11-30 14:25:05,675 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,675 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5340.83 Median:5508.09 stddev:564.44 (10.2%) stddev-sans-first:537.49 14:25:05 INFO - 2015-11-30 14:25:05,676 DEBUG : BROWSER_OUTPUT: Values: 3076.1 3210.8 3263.3 3290.0 3326.9 5421.5 5472.4 5487.5 5514.9 5553.4 5315.1 5394.1 5414.8 5445.3 5457.3 4837.7 4958.7 5012.9 5058.7 5063.1 4905.1 4953.5 5029.0 5051.3 5052.4 5015.0 5124.2 5136.9 5144.5 5189.4 4951.2 5038.8 5084.6 5119.2 5183.6 4908.9 5074.5 5075.0 5087.5 5091.3 5169.9 5213.3 5224.7 5248.8 5260.9 5574.2 5577.9 5612.7 5730.6 5806.5 5384.5 5504.3 5508.1 5616.0 5635.6 5207.1 5218.2 5269.3 5334.1 5338.2 5665.8 5725.0 5770.2 5806.4 5863.3 5528.7 5580.2 5590.6 5601.3 5606.3 5725.1 5824.9 5831.2 5833.1 5862.7 5402.3 5447.2 5522.8 5574.7 5666.7 5659.9 5677.9 5753.5 5772.2 5854.5 4383.9 4399.5 4400.1 4437.4 4447.8 3739.1 3844.9 3953.6 3977.0 4049.5 5302.2 5437.2 5440.6 5452.9 5464.4 5792.9 5799.9 5811.6 5895.0 5951.8 5209.0 5314.4 5339.5 5368.4 5402.9 5031.1 5069.1 5107.3 5108.0 5127.8 5845.9 5855.7 5928.8 5949.7 6052.0 5562.1 5628.9 5698.0 5726.1 5766.8 5783.2 5795.0 5821.3 5882.4 5915.6 5623.0 5634.2 5642.3 5645.2 5693.9 5627.9 5634.9 5742.5 5836.9 5916.1 5528.6 5588.3 5642.0 5642.9 5685.5 5394.2 5576.4 5586.4 5655.2 5677.7 5211.1 5312.4 5356.6 5493.5 5530.4 5643.1 5692.0 5701.7 5793.5 5826.3 5572.7 5589.0 5593.4 5624.3 5681.5 14:25:05 INFO - 2015-11-30 14:25:05,676 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,676 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46976.98 Median:30778.42 stddev:77083.27 (250.4%) stddev-sans-first:77220.75 14:25:05 INFO - 2015-11-30 14:25:05,679 DEBUG : BROWSER_OUTPUT: Values: 566.3 567.7 569.6 576.8 607.0 31877.4 33041.3 40711.6 41224.4 41398.4 43189.8 43390.6 43764.0 43972.3 44257.6 8455.2 9102.8 9421.2 9430.0 9471.1 8655.2 11030.6 11283.9 11324.2 11337.8 11019.4 11035.6 11169.3 11201.2 11222.2 8717.2 9027.3 10817.1 10958.7 11042.6 10329.4 11009.6 11029.1 11030.3 11080.5 38764.4 40363.8 40595.6 40709.0 40906.4 2874.3 3029.7 3161.9 3564.1 3579.9 27254.0 27309.6 27513.2 28132.0 28234.4 2279.9 2317.8 2351.4 2371.0 2373.9 272392.0 273395.0 276182.0 277211.0 279148.6 59912.0 64236.4 64563.4 64940.0 65310.0 56218.4 72589.3 72644.6 72988.6 73681.6 17465.9 17499.3 17631.6 17682.6 17692.6 12903.7 13129.6 13274.3 13394.6 13396.7 20001.2 20826.8 20855.6 21153.9 21155.3 8343.6 8606.4 8634.8 8669.4 8673.8 920.5 991.8 1034.5 1082.6 1118.8 28623.3 28722.4 28870.0 29127.1 29143.9 1019.9 1022.7 1053.7 1077.3 1099.8 12859.9 14187.6 14267.3 14430.1 15059.5 332438.0 340437.0 340443.0 341763.0 343991.0 56728.0 56919.9 57185.0 57360.7 58082.7 1325.4 1407.8 1425.2 1440.2 1456.5 27989.2 29066.6 29091.0 29455.0 30167.4 46657.5 46728.0 47726.3 47728.3 48349.8 185465.0 275362.0 275475.0 281536.0 282016.0 30997.0 31347.0 31409.8 31751.4 32068.8 40857.4 41843.6 41997.4 43391.0 43432.8 34403.3 35776.3 35834.0 36136.6 36436.3 35019.3 35350.5 35556.1 36267.6 36774.0 33342.8 34109.0 34137.7 34197.3 34347.7 28649.0 30215.4 30505.7 30559.8 31689.5 24050.4 24345.4 24527.6 24721.4 24870.6 14:25:05 INFO - 2015-11-30 14:25:05,679 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,679 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28093.86 Median:2398.36 stddev:95696.50 (3990.1%) stddev-sans-first:95942.28 14:25:05 INFO - 2015-11-30 14:25:05,680 DEBUG : BROWSER_OUTPUT: Values: 356.6 357.2 359.4 363.5 365.1 14647.6 14913.5 17580.6 17860.7 18668.8 11900.5 12252.5 15077.5 18061.5 18238.9 4359.2 4417.5 4472.2 4490.7 4527.5 3446.5 3484.2 4392.3 4469.5 4791.0 4796.6 4862.8 4877.9 4885.1 4915.8 4806.8 4858.9 4862.0 4871.1 4975.5 4225.7 4256.6 4260.0 4269.6 4281.4 13743.7 13763.4 13957.7 13998.2 14032.8 1884.4 1893.8 1963.8 1993.9 2017.2 9252.7 9346.0 9789.6 10174.8 10274.8 1603.9 1613.9 1615.9 1637.8 1657.6 55145.0 56018.4 59827.7 63264.0 63483.0 6691.9 6778.0 6810.5 6870.4 6881.9 7839.5 7857.2 7886.4 7902.6 7922.6 5537.2 5706.3 5731.5 5749.6 5753.5 6105.1 6140.7 6188.1 6205.6 6209.0 3056.9 3065.5 3118.7 3141.4 3146.6 1057.8 1067.8 1093.1 1123.8 1141.9 419.1 430.4 434.7 437.5 452.4 11768.2 11851.7 11930.8 12401.8 13028.5 445.4 454.1 457.4 481.0 501.1 6243.3 6419.0 6495.6 6502.7 6518.5 571914.0 574818.0 576187.0 593262.0 606783.0 67815.7 68617.0 68823.3 69815.3 69821.7 460.5 466.2 466.8 466.9 499.8 10895.9 10987.9 11031.7 11182.7 11300.4 35932.5 36315.3 36316.6 36341.0 37205.8 50715.5 50897.7 50918.5 51054.2 51447.7 6507.8 6541.9 6556.6 6557.4 6568.7 11811.5 12175.0 12184.8 12379.4 12447.4 9802.2 10351.0 10585.2 10675.0 10806.9 10121.5 10170.2 10242.1 10374.1 10564.3 8390.9 10476.8 10769.2 10870.9 10873.3 6391.6 6426.8 6493.7 6570.8 6575.5 10506.7 10511.2 10846.5 10847.1 10891.7 14:25:05 INFO - 2015-11-30 14:25:05,680 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,680 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5088.17 Median:6304.04 stddev:2611.02 (41.4%) stddev-sans-first:2602.78 14:25:05 INFO - 2015-11-30 14:25:05,680 DEBUG : BROWSER_OUTPUT: Values: 1295.3 1391.2 1401.8 1585.5 1851.2 6723.5 7306.5 7328.8 7408.0 7432.9 7216.1 7474.4 7480.8 7496.1 7632.8 2020.4 2092.8 2101.9 2108.6 2138.8 2148.0 2196.2 2200.8 2219.7 2227.8 2129.5 2129.8 2137.8 2145.1 2155.7 2086.8 2112.8 2120.5 2127.8 2145.4 2165.3 2173.4 2200.2 2202.5 2208.5 6712.6 6795.5 7342.1 7398.0 7412.2 4461.3 4536.4 4556.4 4591.6 4599.8 2687.6 2700.0 2725.9 2788.9 2811.1 865.8 868.3 883.7 884.3 884.7 9630.2 9743.5 9780.6 9799.5 9826.0 4049.3 4132.0 4138.2 4185.7 4211.7 8770.7 8832.8 8855.9 8884.4 8896.1 4626.1 4650.7 4653.9 4654.6 4661.3 4221.2 4268.5 4268.8 4272.7 4279.2 3442.2 3454.3 3457.2 3485.9 3498.6 1095.5 1100.8 1105.3 1111.9 1117.1 1256.0 1270.0 1293.9 1306.3 1344.1 6727.0 6802.6 7060.8 7102.2 7147.9 480.4 492.5 493.0 494.7 497.1 5281.2 5328.8 5344.5 5377.5 5485.6 7844.7 8435.3 8515.0 8573.0 8591.1 7942.8 8350.9 8353.5 8456.2 8507.1 6635.1 6716.9 6825.0 6829.6 6841.9 6675.6 6754.5 6767.4 6772.4 6806.3 7467.2 7626.9 7680.0 7688.0 7728.5 7783.4 7843.8 7904.5 7914.7 7928.4 6476.5 6506.2 6509.5 6523.5 6529.5 7004.5 7005.5 7032.3 7053.2 7151.0 6240.9 6370.0 6416.6 6461.7 6511.3 6480.9 6523.0 6564.3 6576.5 6583.0 6367.1 6409.0 6423.0 6521.3 6522.4 5539.8 5866.4 5909.9 5925.2 5964.0 5985.1 6013.1 6047.0 6057.5 6064.8 14:25:05 INFO - 2015-11-30 14:25:05,680 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,680 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5351.80 Median:6130.18 stddev:1609.17 (26.2%) stddev-sans-first:1568.80 14:25:05 INFO - 2015-11-30 14:25:05,682 DEBUG : BROWSER_OUTPUT: Values: 323.7 323.8 326.1 326.8 329.4 6130.4 6162.9 6189.2 6202.4 6245.5 6047.2 6058.8 6063.1 6072.5 6092.7 4720.4 4721.5 4732.4 4781.9 4817.3 4677.0 4749.8 4804.6 4813.7 4873.1 4722.9 4745.6 4748.1 4762.4 4783.0 4550.4 4769.2 4773.1 4775.3 4799.7 4012.0 4014.3 4094.8 4141.4 4180.3 5856.6 5903.0 5903.9 5913.7 5979.0 5070.5 5090.3 5107.8 5184.7 5243.9 6264.2 6278.8 6301.9 6310.4 6311.3 4338.7 4346.1 4348.0 4382.1 4399.1 6470.6 6633.5 6658.1 6773.8 6794.0 4418.0 4438.8 4474.2 4527.9 4550.5 4431.4 4511.6 4532.3 4605.8 4626.1 5201.0 5203.1 5239.9 5277.3 5316.0 6142.3 6181.4 6353.0 6405.4 6415.9 1588.8 1614.0 1632.2 1632.9 1639.8 1061.0 1077.6 1082.7 1092.4 1108.0 6101.0 6114.8 6130.0 6135.2 6152.9 6652.8 6664.1 6682.9 6687.6 6767.4 5953.3 6075.2 6111.5 6137.5 6170.1 3564.6 3600.0 3667.3 3680.4 3687.3 6665.5 6717.4 6744.1 6766.2 6782.0 6365.3 6725.1 6759.2 6809.1 6832.6 6152.6 6548.9 6582.7 6797.4 6893.3 6649.7 6724.4 6725.8 6733.4 6790.1 6511.8 6526.1 6596.6 6614.4 6683.5 6597.2 6712.5 6733.4 6769.7 6783.0 4165.3 4185.6 4194.4 4221.7 4245.3 6537.4 6550.4 6557.9 6598.1 6660.8 6299.9 6368.9 6470.5 6475.3 6489.0 6438.4 6438.5 6455.7 6466.9 6471.1 6252.3 6275.9 6279.3 6318.3 6366.3 6234.8 6397.4 6408.1 6411.5 6451.2 6347.9 6367.1 6383.5 6397.0 6409.1 14:25:05 INFO - 2015-11-30 14:25:05,682 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-11-30 14:25:05,682 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13210.22 Median:3205.24 stddev:16769.73 (523.2%) stddev-sans-first:16790.19 14:25:05 INFO - 2015-11-30 14:25:05,683 DEBUG : BROWSER_OUTPUT: Values: 636.6 643.2 690.2 770.5 781.1 12993.5 13201.4 13447.9 13486.1 13568.5 12899.4 12939.1 13048.6 13103.1 13127.1 735.6 743.1 884.8 895.7 906.4 893.7 901.9 911.2 912.2 917.0 929.3 940.4 940.6 942.3 945.6 750.1 767.9 925.3 944.7 959.2 682.1 699.8 700.5 703.4 715.6 12507.1 12671.4 12786.3 12828.7 12836.4 11246.9 11437.1 11576.8 11848.8 12035.9 9190.6 9226.0 9341.3 9435.9 9517.4 3252.5 3391.5 3392.5 3398.7 3473.8 47609.5 48238.0 48323.5 49242.5 50156.0 8790.0 8891.6 8967.4 8994.6 9033.6 12068.1 12108.9 12315.4 12399.5 12408.4 5800.9 5819.5 5928.5 5979.2 6065.5 3374.6 3481.8 3483.1 3596.4 3754.1 2576.4 2602.8 2604.7 2613.5 2640.4 395.2 404.3 405.1 408.8 409.2 460.0 463.5 480.8 510.7 591.0 7315.8 7354.7 7397.7 7445.4 7480.4 461.3 461.8 461.9 501.6 507.8 3259.5 3367.9 3469.1 3500.3 3519.1 61569.7 61824.0 61856.0 62004.0 62927.7 51155.0 53033.0 53318.2 53950.0 53974.7 47085.8 47845.0 48214.0 48650.8 48841.8 6860.5 6910.4 6965.1 7010.3 7027.8 33586.7 34358.3 34718.8 34770.5 35314.9 43379.1 44439.0 45370.5 47251.3 47466.0 6406.6 6550.6 6694.8 6769.1 6836.1 10092.7 10168.6 10258.8 10295.3 10380.6 9063.2 9701.6 9759.3 9911.7 9944.1 9412.9 9501.0 9568.9 9579.8 9707.1 9139.8 9349.3 9527.6 9611.0 9627.9 8279.8 8310.0 8376.7 8909.0 9256.6 8060.5 8145.8 8147.3 8909.2 9025.8 14:25:05 INFO - 2015-11-30 14:25:05,683 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:25:05 INFO - 2015-11-30 14:25:05,683 DEBUG : BROWSER_OUTPUT: 14:25:06 INFO - 2015-11-30 14:25:06,334 INFO : Browser exited with error code: 0 14:25:06 INFO - 2015-11-30 14:25:06,361 INFO : Completed test dromaeo_css (00:18:34) 14:25:06 INFO - 2015-11-30 14:25:06,361 INFO : Starting test kraken 14:25:06 INFO - 2015-11-30 14:25:06,361 DEBUG : operating with platform_type : mac_ 14:25:06 INFO - 2015-11-30 14:25:06,362 INFO : Initialising browser for kraken test... 14:25:06 INFO - 2015-11-30 14:25:06,374 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmp75brj0/profile http://localhost:49267/getInfo.html 14:25:08 INFO - 2015-11-30 14:25:08,567 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:25:08 INFO - 2015-11-30 14:25:08,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:25:08 INFO - 2015-11-30 14:25:08,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:25:08 INFO - 2015-11-30 14:25:08,568 DEBUG : BROWSER_OUTPUT: __metrics 14:25:08 INFO - 2015-11-30 14:25:08,575 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:09 INFO - 2015-11-30 14:25:09,233 INFO : Browser initialized. 14:25:09 INFO - 2015-11-30 14:25:09,233 INFO : Running cycle 1/1 for kraken test... 14:25:09 INFO - 2015-11-30 14:25:09,233 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmp75brj0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:25:21 INFO - 2015-11-30 14:25:21,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 199176192 14:25:21 INFO - 2015-11-30 14:25:21,092 DEBUG : BROWSER_OUTPUT: 14:25:23 INFO - 2015-11-30 14:25:23,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:24 INFO - 2015-11-30 14:25:24,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 266051584 14:25:24 INFO - 2015-11-30 14:25:24,254 DEBUG : BROWSER_OUTPUT: 14:25:26 INFO - 2015-11-30 14:25:26,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 14:25:27 INFO - 2015-11-30 14:25:27,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 279318528 14:25:27 INFO - 2015-11-30 14:25:27,470 DEBUG : BROWSER_OUTPUT: 14:25:30 INFO - 2015-11-30 14:25:30,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 14:25:30 INFO - 2015-11-30 14:25:30,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 268705792 14:25:30 INFO - 2015-11-30 14:25:30,885 DEBUG : BROWSER_OUTPUT: 14:25:32 INFO - 2015-11-30 14:25:32,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 14:25:33 INFO - 2015-11-30 14:25:33,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 269336576 14:25:33 INFO - 2015-11-30 14:25:33,509 DEBUG : BROWSER_OUTPUT: 14:25:35 INFO - 2015-11-30 14:25:35,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:36 INFO - 2015-11-30 14:25:36,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 269123584 14:25:36 INFO - 2015-11-30 14:25:36,278 DEBUG : BROWSER_OUTPUT: 14:25:39 INFO - 2015-11-30 14:25:39,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:39 INFO - 2015-11-30 14:25:39,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 270065664 14:25:39 INFO - 2015-11-30 14:25:39,880 DEBUG : BROWSER_OUTPUT: 14:25:42 INFO - 2015-11-30 14:25:42,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:43 INFO - 2015-11-30 14:25:43,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 269164544 14:25:43 INFO - 2015-11-30 14:25:43,561 DEBUG : BROWSER_OUTPUT: 14:25:46 INFO - 2015-11-30 14:25:46,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 14:25:47 INFO - 2015-11-30 14:25:47,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 270475264 14:25:47 INFO - 2015-11-30 14:25:47,004 DEBUG : BROWSER_OUTPUT: 14:25:48 INFO - 2015-11-30 14:25:48,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:49 INFO - 2015-11-30 14:25:49,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 301772800 14:25:49 INFO - 2015-11-30 14:25:49,174 DEBUG : BROWSER_OUTPUT: 14:25:50 INFO - 2015-11-30 14:25:50,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:51 INFO - 2015-11-30 14:25:51,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 302657536 14:25:51 INFO - 2015-11-30 14:25:51,604 DEBUG : BROWSER_OUTPUT: 14:25:53 INFO - 2015-11-30 14:25:53,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:54 INFO - 2015-11-30 14:25:54,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 308469760 14:25:54 INFO - 2015-11-30 14:25:54,237 DEBUG : BROWSER_OUTPUT: 14:25:56 INFO - 2015-11-30 14:25:56,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:57 INFO - 2015-11-30 14:25:57,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 311087104 14:25:57 INFO - 2015-11-30 14:25:57,324 DEBUG : BROWSER_OUTPUT: 14:25:59 INFO - 2015-11-30 14:25:59,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:00 INFO - 2015-11-30 14:26:00,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 309919744 14:26:00 INFO - 2015-11-30 14:26:00,430 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 14:26:02 INFO - 2015-11-30 14:26:02,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 368660480 14:26:02 INFO - 2015-11-30 14:26:02,404 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,404 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:26:02 INFO - 2015-11-30 14:26:02,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:26:02 INFO - 2015-11-30 14:26:02,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:26:02 INFO - 2015-11-30 14:26:02,405 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:26:02 INFO - 2015-11-30 14:26:02,405 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;107;107;107;108;111;113;107;107;107 14:26:02 INFO - 2015-11-30 14:26:02,405 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;128;163;155;127;146;126;156;148;126 14:26:02 INFO - 2015-11-30 14:26:02,405 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;162;161;162;162;161;162;161 14:26:02 INFO - 2015-11-30 14:26:02,405 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;78;77;120;66;68;69;71;116;64 14:26:02 INFO - 2015-11-30 14:26:02,406 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;100;136;88;90;90;129;89;88;133 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;120;114;114;114;114;115;120;120;120 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;124;124;124;124;123;124;124;124 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;100;102;101;100;103;101;101;101;99 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;61;62;62;62;61;63;73;56;57 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;65;67;67;68;67;66;66;67 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;81;82;81;81;81;81;82;88 14:26:02 INFO - 2015-11-30 14:26:02,407 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;129;121;116;118;119;118;120;117;117 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;144;143;143;134;144;144;143;143;135 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;71;67;68;68;69;69;69;67 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: __startTimestamp1448922362403__endTimestamp 14:26:02 INFO - 2015-11-30 14:26:02,408 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,409 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:26:02 INFO - 2015-11-30 14:26:02,410 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:26:02 INFO - 2015-11-30 14:26:02,410 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,410 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:107.50 stddev:2.10 (2.0%) stddev-sans-first:2.22 14:26:02 INFO - 2015-11-30 14:26:02,410 DEBUG : BROWSER_OUTPUT: Values: 108.0 107.0 107.0 107.0 108.0 111.0 113.0 107.0 107.0 107.0 14:26:02 INFO - 2015-11-30 14:26:02,410 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,411 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.90 Median:151.00 stddev:14.63 (9.7%) stddev-sans-first:14.96 14:26:02 INFO - 2015-11-30 14:26:02,411 DEBUG : BROWSER_OUTPUT: Values: 154.0 128.0 163.0 155.0 127.0 146.0 126.0 156.0 148.0 126.0 14:26:02 INFO - 2015-11-30 14:26:02,411 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,411 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:26:02 INFO - 2015-11-30 14:26:02,411 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 162.0 161.0 162.0 162.0 161.0 162.0 161.0 14:26:02 INFO - 2015-11-30 14:26:02,411 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,412 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:70.00 stddev:20.29 (29.0%) stddev-sans-first:21.50 14:26:02 INFO - 2015-11-30 14:26:02,412 DEBUG : BROWSER_OUTPUT: Values: 84.0 78.0 77.0 120.0 66.0 68.0 69.0 71.0 116.0 64.0 14:26:02 INFO - 2015-11-30 14:26:02,412 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,412 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:88.50 stddev:20.16 (22.8%) stddev-sans-first:21.30 14:26:02 INFO - 2015-11-30 14:26:02,412 DEBUG : BROWSER_OUTPUT: Values: 99.0 100.0 136.0 88.0 90.0 90.0 129.0 89.0 88.0 133.0 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:120.00 stddev:3.07 (2.6%) stddev-sans-first:3.07 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 114.0 114.0 114.0 114.0 115.0 120.0 120.0 120.0 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.10 Median:124.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 124.0 124.0 124.0 124.0 123.0 124.0 124.0 124.0 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,413 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.80 Median:101.00 stddev:1.14 (1.1%) stddev-sans-first:1.17 14:26:02 INFO - 2015-11-30 14:26:02,414 DEBUG : BROWSER_OUTPUT: Values: 100.0 100.0 102.0 101.0 100.0 103.0 101.0 101.0 101.0 99.0 14:26:02 INFO - 2015-11-30 14:26:02,414 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,414 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.00 stddev:4.79 (7.7%) stddev-sans-first:4.81 14:26:02 INFO - 2015-11-30 14:26:02,414 DEBUG : BROWSER_OUTPUT: Values: 57.0 61.0 62.0 62.0 62.0 61.0 63.0 73.0 56.0 57.0 14:26:02 INFO - 2015-11-30 14:26:02,414 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,414 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 14:26:02 INFO - 2015-11-30 14:26:02,415 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 67.0 67.0 68.0 67.0 66.0 66.0 67.0 14:26:02 INFO - 2015-11-30 14:26:02,415 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,415 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.21 (2.7%) stddev-sans-first:2.26 14:26:02 INFO - 2015-11-30 14:26:02,415 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 81.0 82.0 81.0 81.0 81.0 81.0 82.0 88.0 14:26:02 INFO - 2015-11-30 14:26:02,415 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,417 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.00 stddev:3.69 (3.1%) stddev-sans-first:3.91 14:26:02 INFO - 2015-11-30 14:26:02,417 DEBUG : BROWSER_OUTPUT: Values: 119.0 129.0 121.0 116.0 118.0 119.0 118.0 120.0 117.0 117.0 14:26:02 INFO - 2015-11-30 14:26:02,417 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,417 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:143.00 stddev:3.78 (2.6%) stddev-sans-first:3.97 14:26:02 INFO - 2015-11-30 14:26:02,417 DEBUG : BROWSER_OUTPUT: Values: 143.0 144.0 143.0 143.0 134.0 144.0 144.0 143.0 143.0 135.0 14:26:02 INFO - 2015-11-30 14:26:02,417 DEBUG : BROWSER_OUTPUT: 14:26:02 INFO - 2015-11-30 14:26:02,418 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 14:26:02 INFO - 2015-11-30 14:26:02,418 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 71.0 67.0 68.0 68.0 69.0 69.0 69.0 67.0 14:26:02 INFO - 2015-11-30 14:26:02,418 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:26:02 INFO - 2015-11-30 14:26:02,418 DEBUG : BROWSER_OUTPUT: 14:26:03 INFO - 2015-11-30 14:26:03,072 INFO : Browser exited with error code: 0 14:26:03 INFO - 2015-11-30 14:26:03,119 INFO : Completed test kraken (00:00:56) 14:26:03 INFO - 2015-11-30 14:26:03,120 INFO : Starting test v8_7 14:26:03 INFO - 2015-11-30 14:26:03,120 DEBUG : operating with platform_type : mac_ 14:26:03 INFO - 2015-11-30 14:26:03,120 INFO : Initialising browser for v8_7 test... 14:26:03 INFO - 2015-11-30 14:26:03,133 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmphk5DBd/profile http://localhost:49267/getInfo.html 14:26:05 INFO - 2015-11-30 14:26:05,252 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:26:05 INFO - 2015-11-30 14:26:05,252 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:26:05 INFO - 2015-11-30 14:26:05,252 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:26:05 INFO - 2015-11-30 14:26:05,252 DEBUG : BROWSER_OUTPUT: __metrics 14:26:05 INFO - 2015-11-30 14:26:05,270 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:26:05 INFO - 2015-11-30 14:26:05,926 INFO : Browser initialized. 14:26:05 INFO - 2015-11-30 14:26:05,926 INFO : Running cycle 1/1 for v8_7 test... 14:26:05 INFO - 2015-11-30 14:26:05,927 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmphk5DBd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:26:17 INFO - 2015-11-30 14:26:17,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 199012352 14:26:17 INFO - 2015-11-30 14:26:17,747 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 14:26:39 INFO - 2015-11-30 14:26:39,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 527249408 14:26:39 INFO - 2015-11-30 14:26:39,428 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,428 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:26:39 INFO - 2015-11-30 14:26:39,428 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |0;Richards;166.16816218012627 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.05846388995033 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.1578604044357 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5780.346820809248 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1009.0817356205853 14:26:39 INFO - 2015-11-30 14:26:39,429 DEBUG : BROWSER_OUTPUT: |5;Earley;678.8866259334691 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: |7;RegExp;29970.58823529412 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: |8;Splay;582.0721769499418 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: __startTimestamp1448922399422__endTimestamp 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:26:39 INFO - 2015-11-30 14:26:39,430 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: Values: 166.2 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: Values: 191.1 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,431 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.16 Median:326.16 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: Values: 326.2 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5780.35 Median:5780.35 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: Values: 5780.3 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1009.08 Median:1009.08 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: Values: 1009.1 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:678.89 Median:678.89 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: Values: 678.9 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: Values: 12180.7 14:26:39 INFO - 2015-11-30 14:26:39,432 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29970.59 Median:29970.59 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: Values: 29970.6 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:582.07 Median:582.07 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: Values: 582.1 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: Values: 5797.7 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:26:39 INFO - 2015-11-30 14:26:39,433 DEBUG : BROWSER_OUTPUT: 14:26:40 INFO - 2015-11-30 14:26:40,055 INFO : Browser exited with error code: 0 14:26:40 INFO - 2015-11-30 14:26:40,074 INFO : Completed test v8_7 (00:00:36) 14:26:40 INFO - 2015-11-30 14:26:40,571 INFO : Completed test suite (00:20:08) 14:26:40 INFO - 2015-11-30 14:26:40,571 DEBUG : Working with test: dromaeo_css 14:26:40 INFO - 2015-11-30 14:26:40,571 DEBUG : Generating results file: dromaeo_css 14:26:40 INFO - 2015-11-30 14:26:40,572 DEBUG : Working with test: kraken 14:26:40 INFO - 2015-11-30 14:26:40,572 DEBUG : Generating results file: kraken 14:26:40 INFO - 2015-11-30 14:26:40,572 INFO : javascript benchmark 14:26:40 INFO - 2015-11-30 14:26:40,573 DEBUG : Working with test: v8_7 14:26:40 INFO - 2015-11-30 14:26:40,573 DEBUG : Generating results file: v8_7 14:26:40 INFO - 2015-11-30 14:26:40,573 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:26:40 INFO - 2015-11-30 14:26:40,642 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 14:26:40 INFO - 2015-11-30 14:26:40,643 DEBUG : process_Request line: dromaeo_css 6530.32 graph.html#tests=[[72,52,55]] 14:26:40 INFO - 2015-11-30 14:26:40,643 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:26:40 INFO - 2015-11-30 14:26:40,686 DEBUG : process_Request line: kraken 1479.70 graph.html#tests=[[232,52,55]] 14:26:40 INFO - 2015-11-30 14:26:40,686 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:26:40 INFO - 2015-11-30 14:26:40,718 DEBUG : process_Request line: v8_7 20386.99 graph.html#tests=[[230,52,55]] 14:26:40 INFO - 2015-11-30 14:26:40,719 INFO : javascript benchmark 14:26:40 INFO - 2015-11-30 14:26:40,721 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.5596488336902, 357.15354609575303, 359.40339037198254, 363.53649097400813, 365.1164182677919, 14647.633809154777, 14913.478028268986, 17580.56048598784, 17860.73208901866, 18668.813311866877, 11900.46447909844, 12252.509899604027, 15077.54767356981, 18061.548461288476, 18238.908805455987, 4359.215341238568, 4417.469903611571, 4472.172648060103, 4490.730556166624, 4527.501974782771, 3446.5347178131005, 3484.233468636896, 4392.275274579691, 4469.530699276578, 4790.976045119787, 4796.568308852203, 4862.805487780484, 4877.9268310975185, 4885.145099607572, 4915.778789954443, 4806.807727690888, 4858.927116093279, 4862.0, 4871.12319782439, 4975.477574854661, 4225.746455212667, 4256.59562341577, 4259.998900258437, 4269.594388533084, 4281.443412356373, 13743.725125497534, 13763.449462021606, 13957.720845583133, 13998.160110393306, 14032.807211387044, 1884.415831092352, 1893.7916829148783, 1963.7545306836646, 1993.9202431902706, 2017.1628774058747, 9252.722418327461, 9345.953270233673, 9789.559469823875, 10174.847377289347, 10274.845877311845, 1603.879709021828, 1613.9273732682057, 1615.8949668271525, 1637.8280280570489, 1657.6187476880264, 55145.0, 56018.43981560173, 59827.70086149542, 63264.0, 63482.99999999954, 6691.933080669229, 6778.0, 6810.489213308922, 6870.416014638811, 6881.898896176588, 7839.490433121829, 7857.214278572212, 7886.369090472748, 7902.604869756489, 7922.603869806487, 5537.197106419547, 5706.343770466449, 5731.455511726463, 5749.597528173072, 5753.453421924911, 6105.13793293041, 6140.692965351804, 6188.071789231652, 6205.565610407228, 6209.006558950637, 3056.9235769105508, 3065.494193458099, 3118.703723146343, 3141.4031334046913, 3146.5594816725675, 1057.7778666479971, 1067.8291473364225, 1093.1254996003165, 1123.8370436286857, 1141.9257748246337, 419.1093925408507, 430.42323286795846, 434.6501066641384, 437.5012485766229, 452.4412350746825, 11768.176227663982, 11851.703707407383, 11930.821037684442, 12401.813972790414, 13028.54400095992, 445.37869671807647, 454.0510333403203, 457.3756821938097, 480.9731223837133, 501.0880198039606, 6243.313235544087, 6418.967905160444, 6495.64273964927, 6502.739890404426, 6518.543701940914, 571914.0, 574818.0, 576187.0, 593262.0, 606783.0, 67815.66092169606, 68617.0, 68823.31176688269, 69815.30184698189, 69821.65089174623, 460.49805711774326, 466.24468361254986, 466.79694332965266, 466.8716103071682, 499.7850924102598, 10895.945520272347, 10987.945060274647, 11031.669049928514, 11182.66452006441, 11300.434978251218, 35932.4610130843, 36315.27369452544, 36316.63683363238, 36341.0, 37205.81397092997, 50715.49284507108, 50897.69165004263, 50918.49081509285, 51054.23418648798, 51447.742761285954, 6507.837304067436, 6541.934580654132, 6556.63938483388, 6557.442617377385, 6568.671566421564, 11811.468483918416, 12175.0, 12184.817227741769, 12379.381030948596, 12447.439865206268, 9802.166815820736, 10351.0, 10585.206109541661, 10674.985876341736, 10806.945965270437, 10121.493925303557, 10170.186385089322, 10242.129418999468, 10374.118199953089, 10564.260501764802, 8390.874136888073, 10476.842847357144, 10769.24615276923, 10870.945645271722, 10873.347599144077, 6391.616503009648, 6426.775062872777, 6493.675316234264, 6570.8028759137305, 6575.50683698715, 10506.737331566772, 10511.159107271247, 10846.511906964364, 10847.077998369912, 10891.67324980252], "dojo.html": [3076.123304858113, 3210.8394580270988, 3263.314703912177, 3289.967100328996, 3326.9001929942096, 5421.457854214576, 5472.370677372103, 5487.506124448799, 5514.917276240854, 5553.38912719601, 5315.0698627740185, 5394.05604019297, 5414.810481633143, 5445.319335083114, 5457.263269458622, 4837.685550439211, 4958.652894297401, 5012.924806127911, 5058.696478211301, 5063.063333283336, 4905.068037072962, 4953.504649535035, 5029.044481548494, 5051.343325367716, 5052.368453943257, 5015.0, 5124.231365295217, 5136.948630513703, 5144.4598317176715, 5189.403218629849, 4951.158303088484, 5038.773255203525, 5084.567811736007, 5119.206522988924, 5183.637145399824, 4908.9263661045115, 5074.467180945984, 5075.035743208816, 5087.516685914869, 5091.261767043795, 5169.870753231199, 5213.32226810516, 5224.73876306187, 5248.790048398059, 5260.947390526084, 5574.1917421973585, 5577.944220557783, 5612.663240205601, 5730.570207234432, 5806.506446951972, 5384.515393614593, 5504.311961004874, 5508.091164957777, 5616.0, 5635.633683810539, 5207.0887594670785, 5218.191180367049, 5269.262303277545, 5334.119870221409, 5338.172583249602, 5665.773369065191, 5724.971375143097, 5770.19217309577, 5806.390329015477, 5863.3257175424515, 5528.668279903219, 5580.2466666999435, 5590.608657393944, 5601.327840659147, 5606.327240731139, 5725.112607545837, 5824.912626310609, 5831.241938547962, 5833.125031245262, 5862.736176872051, 5402.324709411324, 5447.155690867922, 5522.779088836402, 5574.665520068809, 5666.716664166775, 5659.886802263932, 5677.914831277534, 5753.4821866031425, 5772.163036359789, 5854.4730974212525, 4383.912321753547, 4399.450068741407, 4400.141972315368, 4437.445319335083, 4447.844325448594, 3739.139997800521, 3844.8654297099465, 3953.584873588289, 3977.0455090778005, 4049.453323801308, 5302.151655735064, 5437.238786569884, 5440.646357986798, 5452.890942181134, 5464.371597266286, 5792.913106303409, 5799.859512078535, 5811.564132690065, 5895.0, 5951.809638072403, 5209.0363282792805, 5314.362276526842, 5339.546138578186, 5368.409474957752, 5402.864928376822, 5031.094403007493, 5069.087564238473, 5107.33604631403, 5107.978404319151, 5127.769250383742, 5845.853853653693, 5855.736491857791, 5928.822135335947, 5949.702514874239, 6052.0, 5562.110062389998, 5628.943710562842, 5698.031334673198, 5726.112452569859, 5766.798162064308, 5783.16144159103, 5795.0, 5821.27234095738, 5882.441168089024, 5915.615484993634, 5623.044082506066, 5634.211210430461, 5642.294713160855, 5645.1532270159805, 5693.914591281051, 5627.8874422512135, 5634.943650563606, 5742.483176514133, 5836.883262334814, 5916.112583112567, 5528.55771538284, 5588.329400471969, 5641.971790141023, 5642.85892852682, 5685.488306052475, 5394.163904594794, 5576.358718747234, 5586.441355864381, 5655.151727240782, 5677.716114194356, 5211.140161873249, 5312.442193569774, 5356.598255130959, 5493.478119578634, 5530.364008139116, 5643.125315576092, 5692.0, 5701.743421545957, 5793.507551858139, 5826.271716035496, 5572.749226284745, 5588.972055139861, 5593.356763972195, 5624.29696287964, 5681.545476361964], "mootools.html": [1295.2940647347195, 1391.1792042694808, 1401.8317801863777, 1585.476792658423, 1851.1854783895094, 6723.529352945289, 7306.452016098788, 7328.816779580513, 7408.0, 7432.888506672391, 7216.134063912338, 7474.364679002291, 7480.7755767326935, 7496.137944136426, 7632.809179770495, 2020.3938818354509, 2092.811646951774, 2101.8949052547387, 2108.599366120432, 2138.77542858, 2147.9892600537055, 2196.2093646287326, 2200.845940784138, 2219.6670499425054, 2227.8106360959337, 2129.510212651091, 2129.84026198035, 2137.8075973162413, 2145.0776166248506, 2155.665871789875, 2086.7704552499213, 2112.7781582933803, 2120.5440830221423, 2127.7872212778752, 2145.442185031887, 2165.2962787094098, 2173.3588591365583, 2200.2189222825828, 2202.5484775620957, 2208.4589275627413, 6712.563683360615, 6795.524313298071, 7342.082239720035, 7398.038255026866, 7412.18465968743, 4461.263891457906, 4536.364908912755, 4556.430446194226, 4591.6097131743845, 4599.770011499445, 2687.583424569195, 2699.9595006074924, 2725.9318517037036, 2788.9302767430977, 2811.072346125794, 865.8354912566592, 868.3443999780188, 883.7039591736776, 884.2881480408269, 884.7390019944067, 9630.229581633523, 9743.464109473976, 9780.608775648965, 9799.461029643368, 9826.017398260188, 4049.331860243086, 4131.97934010334, 4138.193052354762, 4185.727927684691, 4211.663066954698, 8770.693025744069, 8832.77918052041, 8855.911440885637, 8884.37809353339, 8896.110388961051, 4626.051659409813, 4650.720956742606, 4653.906921861611, 4654.604358629486, 4661.300804879295, 4221.2190744712325, 4268.509121451073, 4268.829246830154, 4272.700910936204, 4279.186954478639, 3442.242706604593, 3454.274602333488, 3457.2048428861503, 3485.912852178665, 3498.5626796650417, 1095.5070218401593, 1100.7523307255963, 1105.2594761509808, 1111.9277246979082, 1117.0560876059717, 1256.0, 1270.01573780321, 1293.9158954667917, 1306.3468265867066, 1344.0793056756154, 6726.9657859430035, 6802.591844489347, 7060.7881763547175, 7102.218755936843, 7147.89278160828, 480.4042986696471, 492.4804331430304, 493.03857477918206, 494.6982340772126, 497.1027295731168, 5281.181416880389, 5328.786848526093, 5344.4922732340365, 5377.5429088527135, 5485.561155107662, 7844.725434609762, 8435.283000944866, 8514.957425212959, 8573.014103378191, 8591.097934716765, 7942.841143177104, 8350.916490835136, 8353.457025293337, 8456.238938495442, 8507.149285071444, 6635.10426092481, 6716.865662686817, 6825.010373495816, 6829.556078854958, 6841.863162736718, 6675.632840193836, 6754.459643228432, 6767.39093481589, 6772.424343930624, 6806.319368063154, 7467.215942325977, 7626.885596716164, 7679.961600191963, 7688.038995125609, 7728.497647652885, 7783.377329813715, 7843.803904902423, 7904.486208396436, 7914.6834126636595, 7928.445008849556, 6476.5466417350335, 6506.186726659168, 6509.4792416605615, 6523.510736694861, 6529.542931994714, 7004.544704594185, 7005.474589405917, 7032.261612530815, 7053.224145344111, 7150.998860159478, 6240.937590624036, 6370.012648039561, 6416.647084410216, 6461.67691615408, 6511.34886511345, 6480.902786458113, 6522.967385163044, 6564.277929427854, 6576.506761992965, 6582.967085164543, 6367.140436041075, 6409.0, 6423.03654451836, 6521.250056243593, 6522.445592124723, 5539.833804985857, 5866.3547009828035, 5909.9066672665695, 5925.1704761332585, 5964.0, 5985.132155837467, 6013.067974463965, 6046.969765151146, 6057.545684073624, 6064.848378790565], "ext.html": [566.2751677852349, 567.7274908044136, 569.5984331046612, 576.7981206577698, 607.0257237134397, 31877.36245275093, 33041.339173216555, 40711.592884071186, 41224.38163427551, 41398.379024314585, 43189.784051079776, 43390.56609433905, 43764.0, 43972.3404148938, 44257.557424425744, 8455.239028487435, 9102.817943641123, 9421.199198068172, 9429.952850235739, 9471.10024547667, 8655.177758113, 11030.558777648885, 11283.943580282086, 11324.207305488619, 11337.829932551018, 11019.449027548631, 11035.613753518628, 11169.273997190197, 11201.159913006517, 11222.214444988855, 8717.171868672465, 9027.277817774562, 10817.080548153417, 10958.671239862777, 11042.613508527204, 10329.380237185793, 11009.61466348682, 11029.117670586334, 11030.28303160292, 11080.501377438035, 38764.41853372202, 40363.7981810092, 40595.59404405948, 40709.0, 40906.386404203964, 2874.3101655602713, 3029.681883402255, 3161.920951976196, 3564.0733409313507, 3579.9105022374647, 27254.0, 27309.590356144672, 27513.17460476189, 28132.0, 28234.43531129366, 2279.87460689662, 2317.8377513574055, 2351.376885125443, 2370.9686286465444, 2373.8575685458754, 272392.0, 273395.0, 276182.0, 277211.0, 279148.6042569794, 59912.0, 64236.35763642397, 64563.354366456675, 64940.0, 65310.0, 56218.437815622136, 72589.2741072593, 72644.63677681578, 72988.63505682438, 73681.6315918417, 17465.912670436566, 17499.300027998994, 17631.559211019827, 17682.646347072987, 17692.557686057953, 12903.741925161445, 13129.60611181666, 13274.336283185996, 13394.598162055154, 13396.665083372995, 20001.199952002047, 20826.791732082787, 20855.58288834245, 21153.89423052875, 21155.25956591512, 8343.624536895853, 8606.397552171413, 8634.827303454022, 8669.436486628349, 8673.783155421164, 920.5351297594806, 991.8016396720685, 1034.4879284754095, 1082.637316498966, 1118.7930232906938, 28623.284417889718, 28722.425551488854, 28870.0, 29127.12618621445, 29143.85428072846, 1019.918406527476, 1022.6880801355509, 1053.7260312318851, 1077.2836064017497, 1099.7525556749667, 12859.935700321626, 14187.645308867155, 14267.296521033635, 14430.134191948517, 15059.548213553611, 332438.0, 340437.0, 340443.0, 341763.0, 343991.0, 56728.0, 56919.86160276771, 57185.0, 57360.71319643375, 58082.7095864518, 1325.4499382756048, 1407.7677183264648, 1425.237497938598, 1440.1790979141997, 1456.4683890379936, 27989.160325190278, 29066.56400153957, 29091.0, 29455.0, 30167.396652066396, 46657.533424666675, 46728.0, 47726.284105737745, 47728.28407573959, 48349.7912552175, 185465.0, 275362.0, 275475.0, 281536.0, 282016.0, 30997.0, 31347.0, 31409.842950786013, 31751.364972700878, 32068.83965580157, 40857.38713919353, 41843.581564183965, 41997.37003945004, 43391.0, 43432.782836085615, 34403.311933760684, 35776.28447431089, 35834.0, 36136.63863361333, 36436.27127457489, 35019.29961400707, 35350.46974295439, 35556.11109722174, 36267.637323626426, 36774.0, 33342.83328583342, 34109.0, 34137.658623413445, 34197.316053679286, 34347.656523434445, 28649.0, 30215.395692085596, 30505.694943050286, 30559.847200763856, 31689.5246571297, 24050.39874003164, 24345.39136521601, 24527.632085518373, 24721.381965450288, 24870.626940595543], "prototype.html": [323.6601568353229, 323.7701232125191, 326.1259823672558, 326.769627412674, 329.41857621298396, 6130.356312587181, 6162.907556386658, 6189.226346706661, 6202.379762023796, 6245.469135123514, 6047.244094488189, 6058.787942422016, 6063.060225665018, 6072.453479186872, 6092.66490343031, 4720.409948756405, 4721.480637129913, 4732.384789977298, 4781.928271075936, 4817.253325734508, 4677.0, 4749.833755818547, 4804.5916097131785, 4813.66304358695, 4873.147199240118, 4722.929156062662, 4745.57289843914, 4748.145333839908, 4762.404699412574, 4782.97608511957, 4550.408446901914, 4769.165396055711, 4773.140834649762, 4775.259834725605, 4799.712017278975, 4011.959880401217, 4014.337634290368, 4094.836206551764, 4141.4409054777825, 4180.268453020709, 5856.619319744203, 5903.026000709878, 5903.911441328383, 5913.733881975279, 5979.043353063489, 5070.467600901926, 5090.261912022736, 5107.846764597068, 5184.7148406837605, 5243.86890327741, 6264.248290205204, 6278.811635650938, 6301.873962520724, 6310.432061114522, 6311.305756366796, 4338.717983331074, 4346.0655958968655, 4348.0, 4382.145481631083, 4399.098184872126, 6470.644114573696, 6633.535652504278, 6658.13444252249, 6773.762918297836, 6794.048833163361, 4417.955820441819, 4438.800253988578, 4474.194644963873, 4527.909441811145, 4550.476695180097, 4431.357453169272, 4511.571400716926, 4532.297493888453, 4605.769711514411, 4626.097910907408, 5200.97399513, 5203.089459344676, 5239.895202095937, 5277.340332458442, 5315.973420132952, 6142.262928448615, 6181.443670069625, 6353.047042943595, 6405.3594640535575, 6415.871682566322, 1588.793456850625, 1614.023515772964, 1632.2410079313177, 1632.8693704503612, 1639.8278180790844, 1060.9787804243872, 1077.5528155815248, 1082.680609220282, 1092.4428541443922, 1107.9944600276947, 6101.0, 6114.755409783559, 6130.0, 6135.202423684982, 6152.8769424611255, 6652.833679157963, 6664.133662623828, 6682.866342673119, 6687.598744075371, 6767.35710107539, 5953.28560572734, 6075.210222671113, 6111.54163437735, 6137.508999280047, 6170.10533472644, 3564.572251329857, 3600.0459878132315, 3667.2665466906724, 3680.392735198716, 3687.2809802088336, 6665.533412661067, 6717.429018533382, 6744.055832183498, 6766.15423072116, 6781.9827025945515, 6365.2998170201245, 6725.125733654593, 6759.222689390783, 6809.148856392951, 6832.624205668637, 6152.630842149485, 6548.9017664735065, 6582.670866456658, 6797.422219111233, 6893.276205998298, 6649.700763465559, 6724.361185687352, 6725.798226053226, 6733.42765864907, 6790.083338749206, 6511.837204069936, 6526.118973938457, 6596.571222870498, 6614.437772789367, 6683.465322774264, 6597.175353080865, 6712.49656275791, 6733.360330768569, 6769.661516924232, 6783.016462612992, 4165.271077561354, 4185.5605161458825, 4194.391813187131, 4221.7255878367805, 4245.257080011047, 6537.378948999837, 6550.377714117151, 6557.9344206557325, 6598.142241508765, 6660.766873159416, 6299.905501417391, 6368.872622547616, 6470.48236141117, 6475.3200913903365, 6488.967555162194, 6438.356164383712, 6438.484921206386, 6455.709493072729, 6466.902996455151, 6471.094046833541, 6252.343503932204, 6275.937240627535, 6279.277883043508, 6318.304986451579, 6366.267879193952, 6234.781782637586, 6397.360263973565, 6408.070829729756, 6411.455026322815, 6451.1936007999, 6347.873042539031, 6367.07677386767, 6383.457406120346, 6397.040443933447, 6409.102725618324], "yui.html": [636.6116668832011, 643.173522024199, 690.1752405874978, 770.5338270346442, 781.1212386065677, 12993.480260789569, 13201.405936732857, 13447.932760336209, 13486.12340197889, 13568.457261709533, 12899.419526121324, 12939.094263401566, 13048.608541743739, 13103.14829536082, 13127.0811043227, 735.56601605053, 743.1156923261302, 884.8407286688393, 895.7312806158159, 906.4334790755778, 893.70954439807, 901.9413738107002, 911.1844898815589, 912.238281035333, 917.0187898948128, 929.2612373163352, 940.407543247753, 940.6049459227107, 942.3215284994827, 945.5981207986613, 750.0848964263616, 767.9232076792332, 925.273660176758, 944.6929747831982, 959.2278216036088, 682.0860047536326, 699.7655785311927, 700.4501466348943, 703.4407645921505, 715.5527795128045, 12507.124501284914, 12671.36643167847, 12786.296753678544, 12828.743425131539, 12836.358182090858, 11246.887531124667, 11437.142214333875, 11576.768464630744, 11848.763024739457, 12035.939820300842, 9190.586423610954, 9225.953870230605, 9341.346105772598, 9435.858462123073, 9517.428954262698, 3252.4796032634663, 3391.5082313064713, 3392.4572068469174, 3398.694117529434, 3473.7568370214094, 47609.523904761205, 48238.0, 48323.51676483225, 49242.50757492415, 50155.999999999636, 8790.0, 8891.599878005505, 8967.372283940062, 8994.595243214071, 9033.593488293043, 12068.09489288307, 12108.939455302667, 12315.384230788424, 12399.504019839285, 12408.441620127116, 5800.854978625568, 5819.476247137778, 5928.466438020599, 5979.162917191509, 6065.514758819284, 3374.578177727784, 3481.7562770606323, 3483.1466290758926, 3596.4065929121402, 3754.0990162360836, 2576.4203054313007, 2602.843829370244, 2604.70045944715, 2613.5426300397353, 2640.353113487208, 395.1997205658507, 404.2501160347572, 405.0905716666045, 408.844639037164, 409.17346959142367, 459.9862004139881, 463.53414818107586, 480.79085597765084, 510.6782726882115, 590.9940900591025, 7315.780526584211, 7354.669039893218, 7397.667104980289, 7445.362020355513, 7480.438967077491, 461.2757969987088, 461.7621924708778, 461.93301971213987, 501.55612283129693, 507.82315455379944, 3259.4784834426378, 3367.915802104918, 3469.098034511045, 3500.299940012008, 3519.1202199450136, 61569.692151538955, 61824.0, 61856.0, 62004.0, 62927.685361573815, 51155.0, 53033.0, 53318.200226996625, 53950.0, 53974.73012634912, 47085.76457117761, 47845.0, 48214.0, 48650.75674621675, 48841.755791220814, 6860.451163906776, 6910.378065973885, 6965.059716938148, 7010.298970102949, 7027.754028608974, 33586.66413335933, 34358.31283374369, 34718.82640586882, 34770.478442822874, 35314.92640225366, 43379.132417352106, 44439.0, 45370.54629453663, 47251.29123063088, 47466.0, 6406.615603063831, 6550.574212676161, 6694.799156025327, 6769.086173366532, 6836.145481814773, 10092.747681307732, 10168.593256269667, 10258.794824103326, 10295.330803497749, 10380.636677716244, 9063.229625481645, 9701.563429645825, 9759.268054896052, 9911.702648920544, 9944.105030547285, 9412.858807117762, 9501.0, 9568.904310956801, 9579.760505987406, 9707.077827606367, 9139.817203655757, 9349.25205983506, 9527.618895244113, 9611.0, 9627.9037209627, 8279.793005174919, 8310.0, 8376.748697539084, 8908.955455222682, 9256.629734810533, 8060.476069055492, 8145.755627331189, 8147.266745992889, 8909.242714369091, 9025.819483610423]}, "summary": {"suite": 6530.317009248689, "subtests": {"jquery.html": {"filtered": 6827.111115097989, "value": 6827.111115097989}, "dojo.html": {"filtered": 5305.679956198774, "value": 5305.679956198774}, "mootools.html": {"filtered": 4136.272662106422, "value": 4136.272662106422}, "ext.html": {"filtered": 18922.81779789185, "value": 18922.81779789185}, "prototype.html": {"filtered": 4823.566146122258, "value": 4823.566146122258}, "yui.html": {"filtered": 5670.5261464799905, "value": 5670.5261464799905}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0050"}, "testrun": {"date": 1448921191, "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": "20151130131332", "branch": "Mozilla-Aurora", "revision": "27a9ba2d01e9f0b987f1debb45e782d84a896d37"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0], "ai-astar": [108.0, 107.0, 107.0, 107.0, 108.0, 111.0, 113.0, 107.0, 107.0, 107.0], "imaging-gaussian-blur": [120.0, 120.0, 114.0, 114.0, 114.0, 114.0, 115.0, 120.0, 120.0, 120.0], "audio-beat-detection": [154.0, 128.0, 163.0, 155.0, 127.0, 146.0, 126.0, 156.0, 148.0, 126.0], "json-stringify-tinderbox": [65.0, 66.0, 65.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [143.0, 144.0, 143.0, 143.0, 134.0, 144.0, 144.0, 143.0, 143.0, 135.0], "json-parse-financial": [57.0, 61.0, 62.0, 62.0, 62.0, 61.0, 63.0, 73.0, 56.0, 57.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 71.0, 67.0, 68.0, 68.0, 69.0, 69.0, 69.0, 67.0], "audio-fft": [84.0, 78.0, 77.0, 120.0, 66.0, 68.0, 69.0, 71.0, 116.0, 64.0], "imaging-darkroom": [125.0, 125.0, 124.0, 124.0, 124.0, 124.0, 123.0, 124.0, 124.0, 124.0], "stanford-crypto-ccm": [119.0, 129.0, 121.0, 116.0, 118.0, 119.0, 118.0, 120.0, 117.0, 117.0], "audio-oscillator": [99.0, 100.0, 136.0, 88.0, 90.0, 90.0, 129.0, 89.0, 88.0, 133.0], "stanford-crypto-aes": [84.0, 82.0, 81.0, 82.0, 81.0, 81.0, 81.0, 81.0, 82.0, 88.0], "imaging-desaturate": [100.0, 100.0, 102.0, 101.0, 100.0, 103.0, 101.0, 101.0, 101.0, 99.0]}, "summary": {"suite": 1479.7, "subtests": {"audio-fft": {"filtered": 81.3, "value": 81.3}, "stanford-crypto-pbkdf2": {"filtered": 141.6, "value": 141.6}, "audio-beat-detection": {"filtered": 142.9, "value": 142.9}, "stanford-crypto-ccm": {"filtered": 119.4, "value": 119.4}, "imaging-darkroom": {"filtered": 124.1, "value": 124.1}, "json-parse-financial": {"filtered": 61.4, "value": 61.4}, "audio-oscillator": {"filtered": 104.2, "value": 104.2}, "ai-astar": {"filtered": 108.2, "value": 108.2}, "audio-dft": {"filtered": 161.7, "value": 161.7}, "stanford-crypto-sha256-iterative": {"filtered": 68.3, "value": 68.3}, "json-stringify-tinderbox": {"filtered": 66.4, "value": 66.4}, "imaging-gaussian-blur": {"filtered": 117.1, "value": 117.1}, "stanford-crypto-aes": {"filtered": 82.3, "value": 82.3}, "imaging-desaturate": {"filtered": 100.8, "value": 100.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0050"}, "testrun": {"date": 1448921191, "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": "20151130131332", "branch": "Mozilla-Aurora", "revision": "27a9ba2d01e9f0b987f1debb45e782d84a896d37"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.05846388995033], "Encrypt": [326.1578604044357], "NavierStokes": [5797.687861271676], "Decrypt": [5780.346820809248], "Splay": [582.0721769499418], "Richards": [166.16816218012627], "RegExp": [29970.58823529412], "Earley": [678.8866259334691], "Boyer": [12180.722891566265], "RayTrace": [1009.0817356205853]}, "summary": {"suite": 20386.994358010394, "subtests": {"DeltaBlue": {"filtered": 346.061612, "value": 346.061612}, "Encrypt": {"filtered": 816.1109459999999, "value": 816.1109459999999}, "NavierStokes": {"filtered": 255.96410767696923, "value": 255.96410767696923}, "Decrypt": {"filtered": 46.049312999999984, "value": 46.049312999999984}, "Splay": {"filtered": 140.001538, "value": 140.001538}, "RegExp": {"filtered": 30.395966633954842, "value": 30.395966633954842}, "Richards": {"filtered": 212.4474360000001, "value": 212.4474360000001}, "Earley": {"filtered": 981.6999990000005, "value": 981.6999990000005}, "Boyer": {"filtered": 54.714568743818035, "value": 54.714568743818035}, "RayTrace": {"filtered": 733.3290990000002, "value": 733.3290990000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0050"}, "testrun": {"date": 1448921191, "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": "20151130131332", "branch": "Mozilla-Aurora", "revision": "27a9ba2d01e9f0b987f1debb45e782d84a896d37"}}] 14:26:40 INFO - RETURN: dromaeo_css: 6530.32 14:26:40 INFO - RETURN: kraken: 1479.70 14:26:40 INFO - RETURN: v8_7: 20386.99 14:26:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20386.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1479.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6530.32"}}} 14:26:40 INFO - Return code: 0 14:26:40 INFO - # TBPL SUCCESS # 14:26:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:26:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:26:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:26:40 INFO - 2015-11-30 14:26:40.828 screenresolution[1667:10916] starting screenresolution argv=screenresolution get 14:26:40 INFO - 2015-11-30 14:26:40.831 screenresolution[1667:10916] Display 0: 1600x1200x32@60 14:26:40 INFO - 2015-11-30 14:26:40.837 screenresolution[1668:10919] starting screenresolution argv=screenresolution list 14:26:40 INFO - Available Modes on Display 0 14:26:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:26:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:26:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:26:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:26:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:26:41 INFO - Intel HD Graphics 3000: 14:26:41 INFO - Chipset Model: Intel HD Graphics 3000 14:26:41 INFO - Type: GPU 14:26:41 INFO - Bus: Built-In 14:26:41 INFO - VRAM (Total): 512 MB 14:26:41 INFO - VRAM (Dynamic, Max): 10 14:26:41 INFO - Vendor: Intel (0x8086) 14:26:41 INFO - Device ID: 0x0116 14:26:41 INFO - Revision ID: 0x0009 14:26:41 INFO - Displays: 14:26:41 INFO - Display: 14:26:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:26:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:26:41 INFO - Display Serial Number: 1600x1200 60 14:26:41 INFO - Main Display: Yes 14:26:41 INFO - Mirror: Off 14:26:41 INFO - Online: Yes 14:26:41 INFO - Rotation: Supported 14:26:41 INFO - Return code: 0 14:26:41 INFO - Running post-action listener: _resource_record_post_action 14:26:41 INFO - Running post-run listener: _resource_record_post_run 14:26:42 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 39207936; Write bytes: 686718976; Read time: 4518; Write time: 45410 14:26:42 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 334387712; Write bytes: 332986368; Read time: 32955; Write time: 3208 14:26:42 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 38306816; Write bytes: 343472128; Read time: 3842; Write time: 41211 14:26:42 INFO - Running post-run listener: _upload_blobber_files 14:26:42 INFO - Blob upload gear active. 14:26:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:26:42 INFO - Copying logs to upload dir... 14:26:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1369.504112 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 49 secs) (at 2015-11-30 14:26:42.236681) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 14:26:42.240358) ========= 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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010076 build_url: 'https://queue.taskcluster.net/v1/task/xpmPlJvqSkCBzu1Of9BVAQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 14:26:42.261036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:26:42.261338) ========= 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.bJYPHQEeuE/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.LT6ezA4z9r/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/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.004999 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 14:26:42.310793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 14:26:42.311106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 14:26:42.311454) ========= ========= Total master_lag: 4.11 =========